builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-010 starttime: 1480649761.13 results: success (0) buildid: 20161201184344 builduid: ef297ffe42384c49abda34f6edfd7899 revision: 02fdf5d71d8e22357c82e0ab828544f4cd2f1250 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-01 19:36:01.128489) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-01 19:36:01.129016) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-01 19:36:01.129338) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-01 19:36:01.143201) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 19:36:01.144064) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1480649761.120091-1069115570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-01 19:36:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.7M=0s 2016-12-01 19:36:01 (40.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.156862 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 19:36:01.313718) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 19:36:01.314029) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1480649761.120091-1069115570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017277 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 19:36:01.363218) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 19:36:01.363616) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 02fdf5d71d8e22357c82e0ab828544f4cd2f1250 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 02fdf5d71d8e22357c82e0ab828544f4cd2f1250 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1480649761.120091-1069115570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-01 19:36:02,024 truncating revision to first 12 chars 2016-12-01 19:36:02,024 Setting DEBUG logging. 2016-12-01 19:36:02,024 attempt 1/10 2016-12-01 19:36:02,024 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/02fdf5d71d8e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-01 19:36:02,395 unpacking tar archive at: graphics-02fdf5d71d8e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.681697 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 19:36:02.058705) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-01 19:36:02.059075) ========= script_repo_revision: 02fdf5d71d8e22357c82e0ab828544f4cd2f1250 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-01 19:36:02.059508) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-01 19:36:02.059778) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-01 19:36:02.070767) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-12-01 19:36:02.071193) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1480649761.120091-1069115570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:36:02 INFO - MultiFileLogger online at 20161201 19:36:02 in /builds/slave/test 19:36:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 19:36:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:36:02 INFO - {'append_to_log': False, 19:36:02 INFO - 'base_work_dir': '/builds/slave/test', 19:36:02 INFO - 'blob_upload_branch': 'Graphics', 19:36:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:36:02 INFO - 'branch': 'Graphics', 19:36:02 INFO - 'buildbot_json_path': 'buildprops.json', 19:36:02 INFO - 'config_files': ('talos/linux_config.py',), 19:36:02 INFO - 'default_actions': ('clobber', 19:36:02 INFO - 'read-buildbot-config', 19:36:02 INFO - 'download-and-extract', 19:36:02 INFO - 'populate-webroot', 19:36:02 INFO - 'create-virtualenv', 19:36:02 INFO - 'install', 19:36:02 INFO - 'run-tests'), 19:36:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:36:02 INFO - 'download_minidump_stackwalk': True, 19:36:02 INFO - 'download_symbols': 'ondemand', 19:36:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:36:02 INFO - 'tooltool.py': '/tools/tooltool.py', 19:36:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:36:02 INFO - '/tools/misc-python/virtualenv.py')}, 19:36:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:36:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:36:02 INFO - 'installer_path': 'installer.exe', 19:36:02 INFO - 'log_level': 'info', 19:36:02 INFO - 'log_name': 'talos', 19:36:02 INFO - 'log_to_console': True, 19:36:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:36:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:36:02 INFO - 'opt_config_files': (), 19:36:02 INFO - 'pip_index': False, 19:36:02 INFO - 'sps_profile': False, 19:36:02 INFO - 'sps_profile_interval': 0, 19:36:02 INFO - 'suite': 'dromaeojs', 19:36:02 INFO - 'system_bits': '32', 19:36:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:36:02 INFO - 'title': 'talos-linux64-ix-010', 19:36:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:36:02 INFO - 'use_talos_json': True, 19:36:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:36:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:36:02 INFO - 'work_dir': 'build'} 19:36:02 INFO - [mozharness: 2016-12-02 03:36:02.831601Z] Running clobber step. 19:36:02 INFO - Running pre-action listener: _resource_record_pre_action 19:36:02 INFO - Running main action method: clobber 19:36:02 INFO - rmtree: /builds/slave/test/build 19:36:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:36:03 INFO - Running post-action listener: _resource_record_post_action 19:36:03 INFO - [mozharness: 2016-12-02 03:36:03.298380Z] Finished clobber step (success) 19:36:03 INFO - [mozharness: 2016-12-02 03:36:03.298478Z] Running read-buildbot-config step. 19:36:03 INFO - Running pre-action listener: _resource_record_pre_action 19:36:03 INFO - Running main action method: read_buildbot_config 19:36:03 INFO - Using buildbot properties: 19:36:03 INFO - { 19:36:03 INFO - "project": "", 19:36:03 INFO - "product": "firefox", 19:36:03 INFO - "script_repo_revision": "default", 19:36:03 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 19:36:03 INFO - "repository": "", 19:36:03 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 19:36:03 INFO - "buildid": "20161201184344", 19:36:03 INFO - "pgo_build": "False", 19:36:03 INFO - "basedir": "/builds/slave/test", 19:36:03 INFO - "buildnumber": 14, 19:36:03 INFO - "slavename": "talos-linux64-ix-010", 19:36:03 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:36:03 INFO - "platform": "ubuntu64_hw", 19:36:03 INFO - "scheduler": "tests-graphics-linux64-talos", 19:36:03 INFO - "branch": "graphics", 19:36:03 INFO - "repo_path": "projects/graphics", 19:36:03 INFO - "revision": "02fdf5d71d8e22357c82e0ab828544f4cd2f1250", 19:36:03 INFO - "stage_platform": "linux64", 19:36:03 INFO - "builduid": "ef297ffe42384c49abda34f6edfd7899", 19:36:03 INFO - "slavebuilddir": "test" 19:36:03 INFO - } 19:36:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/GgrvhpapRs-W8Wt5VY36Rw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 19:36:03 INFO - Running post-action listener: _resource_record_post_action 19:36:03 INFO - [mozharness: 2016-12-02 03:36:03.300882Z] Finished read-buildbot-config step (success) 19:36:03 INFO - [mozharness: 2016-12-02 03:36:03.300970Z] Running download-and-extract step. 19:36:03 INFO - Running pre-action listener: _resource_record_pre_action 19:36:03 INFO - Running main action method: download_and_extract 19:36:03 INFO - mkdir: /builds/slave/test/build/tests 19:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:03 INFO - trying https://queue.taskcluster.net/v1/task/GgrvhpapRs-W8Wt5VY36Rw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 19:36:03 INFO - Downloading https://queue.taskcluster.net/v1/task/GgrvhpapRs-W8Wt5VY36Rw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 19:36:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GgrvhpapRs-W8Wt5VY36Rw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:36:03 INFO - Downloaded 1361 bytes. 19:36:03 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 19:36:03 INFO - Using the following test package requirements: 19:36:03 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 19:36:03 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:36:03 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:36:03 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:03 INFO - u'jsshell-linux-x86_64.zip'], 19:36:03 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:36:03 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 19:36:03 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:36:03 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:36:03 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:36:03 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:36:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:36:03 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:36:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GgrvhpapRs-W8Wt5VY36Rw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 19:36:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GgrvhpapRs-W8Wt5VY36Rw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:36:03 INFO - Fetch https://queue.taskcluster.net/v1/task/GgrvhpapRs-W8Wt5VY36Rw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 19:36:04 INFO - Http code: 200 19:36:04 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 19:36:04 INFO - x-amz-cf-id: 8O2VAB3QqLF4OOJbRPI9X7kNeBY5PwzEklFSS2NPgV9oY_MVYyh3ig== 19:36:04 INFO - x-amz-version-id: 7pkgrNdEi9RwMmKUEQsxCcP0onpzomhz 19:36:04 INFO - Expected file size: 20218017 19:36:04 INFO - Obtained file size: 20218017 19:36:08 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:36:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GgrvhpapRs-W8Wt5VY36Rw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 19:36:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GgrvhpapRs-W8Wt5VY36Rw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:36:08 INFO - Fetch https://queue.taskcluster.net/v1/task/GgrvhpapRs-W8Wt5VY36Rw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 19:36:09 INFO - Http code: 200 19:36:09 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 19:36:09 INFO - x-amz-cf-id: Pb5iBGUO-dm5Jc7FXWG1h62kBoXVAjb0hbWnz5MF8k92iIgirh1tuQ== 19:36:09 INFO - x-amz-version-id: 7pkgrNdEi9RwMmKUEQsxCcP0onpzomhz 19:36:09 INFO - Expected file size: 20218017 19:36:09 INFO - Obtained file size: 20218017 19:36:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GgrvhpapRs-W8Wt5VY36Rw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 19:36:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GgrvhpapRs-W8Wt5VY36Rw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:36:13 INFO - Fetch https://queue.taskcluster.net/v1/task/GgrvhpapRs-W8Wt5VY36Rw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 19:36:14 INFO - Http code: 200 19:36:14 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 19:36:14 INFO - x-amz-cf-id: 17SghectACc_Z5AQJubbj0pG4D7JPErGU6Rqw09Dn4GSpsE6YWVJGA== 19:36:14 INFO - x-amz-version-id: bDOwZABtqiCIMpzza4WKJ.WNBqhLpItk 19:36:14 INFO - Expected file size: 14409702 19:36:14 INFO - Obtained file size: 14409702 19:36:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:14 INFO - trying https://queue.taskcluster.net/v1/task/GgrvhpapRs-W8Wt5VY36Rw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 19:36:14 INFO - Downloading https://queue.taskcluster.net/v1/task/GgrvhpapRs-W8Wt5VY36Rw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 19:36:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GgrvhpapRs-W8Wt5VY36Rw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:36:15 INFO - Downloaded 55683241 bytes. 19:36:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GgrvhpapRs-W8Wt5VY36Rw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 19:36:15 INFO - mkdir: /builds/slave/test/properties 19:36:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:36:15 INFO - Writing to file /builds/slave/test/properties/build_url 19:36:15 INFO - Contents: 19:36:15 INFO - build_url:https://queue.taskcluster.net/v1/task/GgrvhpapRs-W8Wt5VY36Rw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 19:36:16 INFO - Running post-action listener: _resource_record_post_action 19:36:16 INFO - Running post-action listener: set_extra_try_arguments 19:36:16 INFO - [mozharness: 2016-12-02 03:36:16.651877Z] Finished download-and-extract step (success) 19:36:16 INFO - [mozharness: 2016-12-02 03:36:16.652176Z] Running populate-webroot step. 19:36:16 INFO - Running pre-action listener: _resource_record_pre_action 19:36:16 INFO - Running main action method: populate_webroot 19:36:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:36:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:36:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:36:16 INFO - '--tppagecycles', 19:36:16 INFO - '7'], 19:36:16 INFO - 'tests': ['tsvgm']}}, 19:36:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:36:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:36:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:36:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:36:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:36:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:36:16 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:36:16 INFO - 'talos_options': ['--disable-e10s'], 19:36:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:36:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:36:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:36:16 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:36:16 INFO - 'talos_options': ['--disable-e10s'], 19:36:16 INFO - 'tests': ['damp', 'tps']}, 19:36:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:36:16 INFO - 'tests': ['damp', 'tps']}, 19:36:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:36:16 INFO - 'tests': ['dromaeo_dom']}, 19:36:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:36:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:36:16 INFO - 'tests': ['basic_compositor_video']}, 19:36:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:36:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:36:16 INFO - 'tests': ['a11yr', 19:36:16 INFO - 'ts_paint', 19:36:16 INFO - 'tpaint', 19:36:16 INFO - 'sessionrestore', 19:36:16 INFO - 'sessionrestore_no_auto_restore', 19:36:16 INFO - 'tabpaint']}, 19:36:16 INFO - 'other-e10s': {'tests': ['a11yr', 19:36:16 INFO - 'ts_paint', 19:36:16 INFO - 'tpaint', 19:36:16 INFO - 'sessionrestore', 19:36:16 INFO - 'sessionrestore_no_auto_restore', 19:36:16 INFO - 'tabpaint']}, 19:36:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:36:16 INFO - 'ts_paint', 19:36:16 INFO - 'tpaint', 19:36:16 INFO - 'sessionrestore', 19:36:16 INFO - 'sessionrestore_no_auto_restore', 19:36:16 INFO - 'tabpaint']}, 19:36:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:36:16 INFO - 'ts_paint', 19:36:16 INFO - 'tpaint', 19:36:16 INFO - 'sessionrestore', 19:36:16 INFO - 'sessionrestore_no_auto_restore', 19:36:16 INFO - 'tabpaint']}, 19:36:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:36:16 INFO - 'tests': ['a11yr', 19:36:16 INFO - 'ts_paint', 19:36:16 INFO - 'tpaint', 19:36:16 INFO - 'sessionrestore', 19:36:16 INFO - 'sessionrestore_no_auto_restore', 19:36:16 INFO - 'tabpaint']}, 19:36:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:36:16 INFO - 'tests': ['a11yr', 19:36:16 INFO - 'ts_paint', 19:36:16 INFO - 'tpaint', 19:36:16 INFO - 'sessionrestore', 19:36:16 INFO - 'sessionrestore_no_auto_restore', 19:36:16 INFO - 'tabpaint']}, 19:36:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:36:16 INFO - 'tests': ['tsvgx', 19:36:16 INFO - 'tsvgr_opacity', 19:36:16 INFO - 'tart', 19:36:16 INFO - 'tscrollx', 19:36:16 INFO - 'cart', 19:36:16 INFO - 'tsvg_static']}, 19:36:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:36:16 INFO - 'tsvgr_opacity', 19:36:16 INFO - 'tart', 19:36:16 INFO - 'tscrollx', 19:36:16 INFO - 'cart', 19:36:16 INFO - 'tsvg_static']}, 19:36:16 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:36:16 INFO - 'talos_options': ['--disable-e10s'], 19:36:16 INFO - 'tests': ['tp5o']}, 19:36:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:36:16 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:36:16 INFO - 'talos_options': ['--disable-e10s', 19:36:16 INFO - '--xperf_path', 19:36:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:36:16 INFO - 'tests': ['tp5n']}, 19:36:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:36:16 INFO - 'talos_options': ['--xperf_path', 19:36:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:36:16 INFO - 'tests': ['tp5n']}}, 19:36:16 INFO - 'talos.zip': {'path': '', 19:36:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:36:16 INFO - Running post-action listener: _resource_record_post_action 19:36:16 INFO - [mozharness: 2016-12-02 03:36:16.673964Z] Finished populate-webroot step (success) 19:36:16 INFO - [mozharness: 2016-12-02 03:36:16.674056Z] Running create-virtualenv step. 19:36:16 INFO - Running pre-action listener: _resource_record_pre_action 19:36:16 INFO - Running main action method: create_virtualenv 19:36:16 INFO - Creating virtualenv /builds/slave/test/build/venv 19:36:16 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:36:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:36:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:36:16 INFO - Using real prefix '/usr' 19:36:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:36:17 INFO - Installing distribute.............................................................................................................................................................................................done. 19:36:19 INFO - Installing pip.................done. 19:36:19 INFO - Return code: 0 19:36:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:36:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:36:19 INFO - Reading from file tmpfile_stdout 19:36:19 INFO - Output received: 19:36:19 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 19:36:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd40f5b9e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbfbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd97130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe25fc0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe26ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe27350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1480649761.120091-1069115570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:36:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:36:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:36:19 INFO - Using env: {'DISPLAY': ':0', 19:36:19 INFO - 'HOME': '/home/cltbld', 19:36:19 INFO - 'LANG': 'en_US.UTF-8', 19:36:19 INFO - 'LANGUAGE': 'en_US:en', 19:36:19 INFO - 'LOGNAME': 'cltbld', 19:36:19 INFO - 'MAIL': '/var/mail/cltbld', 19:36:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:19 INFO - 'MOZ_NO_REMOTE': '1', 19:36:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:19 INFO - 'NO_EM_RESTART': '1', 19:36:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:19 INFO - 'PWD': '/builds/slave/test', 19:36:19 INFO - 'SHELL': '/bin/bash', 19:36:19 INFO - 'SHLVL': '1', 19:36:19 INFO - 'TERM': 'linux', 19:36:19 INFO - 'TMOUT': '86400', 19:36:19 INFO - 'USER': 'cltbld', 19:36:19 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1480649761.120091-1069115570', 19:36:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:19 INFO - '_': '/tools/buildbot/bin/python'} 19:36:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:19 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:36:19 INFO - Cleaning up... 19:36:19 INFO - Return code: 0 19:36:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd40f5b9e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbfbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd97130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe25fc0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe26ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe27350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1480649761.120091-1069115570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:36:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:36:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:36:19 INFO - Using env: {'DISPLAY': ':0', 19:36:19 INFO - 'HOME': '/home/cltbld', 19:36:19 INFO - 'LANG': 'en_US.UTF-8', 19:36:19 INFO - 'LANGUAGE': 'en_US:en', 19:36:19 INFO - 'LOGNAME': 'cltbld', 19:36:19 INFO - 'MAIL': '/var/mail/cltbld', 19:36:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:19 INFO - 'MOZ_NO_REMOTE': '1', 19:36:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:19 INFO - 'NO_EM_RESTART': '1', 19:36:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:19 INFO - 'PWD': '/builds/slave/test', 19:36:19 INFO - 'SHELL': '/bin/bash', 19:36:19 INFO - 'SHLVL': '1', 19:36:19 INFO - 'TERM': 'linux', 19:36:19 INFO - 'TMOUT': '86400', 19:36:19 INFO - 'USER': 'cltbld', 19:36:19 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1480649761.120091-1069115570', 19:36:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:19 INFO - '_': '/tools/buildbot/bin/python'} 19:36:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:19 INFO - Downloading/unpacking psutil>=3.1.1 19:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:36:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:36:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:36:21 INFO - Installing collected packages: psutil 19:36:21 INFO - Running setup.py install for psutil 19:36:22 INFO - building 'psutil._psutil_linux' extension 19:36:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:36:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:36:22 INFO - building 'psutil._psutil_posix' extension 19:36:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:36:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:36:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:36:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:36:22 INFO - Successfully installed psutil 19:36:22 INFO - Cleaning up... 19:36:22 INFO - Return code: 0 19:36:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd40f5b9e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbfbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd97130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe25fc0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe26ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe27350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1480649761.120091-1069115570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:36:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:36:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:36:22 INFO - Using env: {'DISPLAY': ':0', 19:36:22 INFO - 'HOME': '/home/cltbld', 19:36:22 INFO - 'LANG': 'en_US.UTF-8', 19:36:22 INFO - 'LANGUAGE': 'en_US:en', 19:36:22 INFO - 'LOGNAME': 'cltbld', 19:36:22 INFO - 'MAIL': '/var/mail/cltbld', 19:36:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:22 INFO - 'MOZ_NO_REMOTE': '1', 19:36:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:22 INFO - 'NO_EM_RESTART': '1', 19:36:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:22 INFO - 'PWD': '/builds/slave/test', 19:36:22 INFO - 'SHELL': '/bin/bash', 19:36:22 INFO - 'SHLVL': '1', 19:36:22 INFO - 'TERM': 'linux', 19:36:22 INFO - 'TMOUT': '86400', 19:36:22 INFO - 'USER': 'cltbld', 19:36:22 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1480649761.120091-1069115570', 19:36:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:22 INFO - '_': '/tools/buildbot/bin/python'} 19:36:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:36:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:36:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:36:24 INFO - Installing collected packages: mozsystemmonitor 19:36:24 INFO - Running setup.py install for mozsystemmonitor 19:36:24 INFO - Successfully installed mozsystemmonitor 19:36:24 INFO - Cleaning up... 19:36:24 INFO - Return code: 0 19:36:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:36:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd40f5b9e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbfbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd97130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe25fc0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe26ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe27350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1480649761.120091-1069115570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:36:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:36:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:36:24 INFO - Using env: {'DISPLAY': ':0', 19:36:24 INFO - 'HOME': '/home/cltbld', 19:36:24 INFO - 'LANG': 'en_US.UTF-8', 19:36:24 INFO - 'LANGUAGE': 'en_US:en', 19:36:24 INFO - 'LOGNAME': 'cltbld', 19:36:24 INFO - 'MAIL': '/var/mail/cltbld', 19:36:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:24 INFO - 'MOZ_NO_REMOTE': '1', 19:36:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:24 INFO - 'NO_EM_RESTART': '1', 19:36:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:24 INFO - 'PWD': '/builds/slave/test', 19:36:24 INFO - 'SHELL': '/bin/bash', 19:36:24 INFO - 'SHLVL': '1', 19:36:24 INFO - 'TERM': 'linux', 19:36:24 INFO - 'TMOUT': '86400', 19:36:24 INFO - 'USER': 'cltbld', 19:36:24 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1480649761.120091-1069115570', 19:36:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:24 INFO - '_': '/tools/buildbot/bin/python'} 19:36:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:25 INFO - Downloading/unpacking jsonschema==2.5.1 19:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:36:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:27 INFO - Downloading functools32-3.2.3-2.tar.gz 19:36:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:36:27 INFO - warning: no files found matching '*.txt' 19:36:27 INFO - no previously-included directories found matching 'build' 19:36:27 INFO - no previously-included directories found matching 'dist' 19:36:27 INFO - no previously-included directories found matching '.git*' 19:36:27 INFO - Installing collected packages: jsonschema, functools32 19:36:27 INFO - Running setup.py install for functools32 19:36:27 INFO - warning: no files found matching '*.txt' 19:36:27 INFO - no previously-included directories found matching 'build' 19:36:27 INFO - no previously-included directories found matching 'dist' 19:36:27 INFO - no previously-included directories found matching '.git*' 19:36:27 INFO - Successfully installed jsonschema functools32 19:36:27 INFO - Cleaning up... 19:36:27 INFO - Return code: 0 19:36:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd40f5b9e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbfbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd97130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe25fc0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe26ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe27350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1480649761.120091-1069115570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:36:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:36:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:36:27 INFO - Using env: {'DISPLAY': ':0', 19:36:27 INFO - 'HOME': '/home/cltbld', 19:36:27 INFO - 'LANG': 'en_US.UTF-8', 19:36:27 INFO - 'LANGUAGE': 'en_US:en', 19:36:27 INFO - 'LOGNAME': 'cltbld', 19:36:27 INFO - 'MAIL': '/var/mail/cltbld', 19:36:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:27 INFO - 'MOZ_NO_REMOTE': '1', 19:36:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:27 INFO - 'NO_EM_RESTART': '1', 19:36:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:27 INFO - 'PWD': '/builds/slave/test', 19:36:27 INFO - 'SHELL': '/bin/bash', 19:36:27 INFO - 'SHLVL': '1', 19:36:27 INFO - 'TERM': 'linux', 19:36:27 INFO - 'TMOUT': '86400', 19:36:27 INFO - 'USER': 'cltbld', 19:36:27 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1480649761.120091-1069115570', 19:36:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:27 INFO - '_': '/tools/buildbot/bin/python'} 19:36:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:36:27 INFO - Cleaning up... 19:36:27 INFO - Return code: 0 19:36:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd40f5b9e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbfbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd97130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe25fc0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe26ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe27350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1480649761.120091-1069115570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:36:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:36:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:36:27 INFO - Using env: {'DISPLAY': ':0', 19:36:27 INFO - 'HOME': '/home/cltbld', 19:36:27 INFO - 'LANG': 'en_US.UTF-8', 19:36:27 INFO - 'LANGUAGE': 'en_US:en', 19:36:27 INFO - 'LOGNAME': 'cltbld', 19:36:27 INFO - 'MAIL': '/var/mail/cltbld', 19:36:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:27 INFO - 'MOZ_NO_REMOTE': '1', 19:36:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:27 INFO - 'NO_EM_RESTART': '1', 19:36:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:27 INFO - 'PWD': '/builds/slave/test', 19:36:27 INFO - 'SHELL': '/bin/bash', 19:36:27 INFO - 'SHLVL': '1', 19:36:27 INFO - 'TERM': 'linux', 19:36:27 INFO - 'TMOUT': '86400', 19:36:27 INFO - 'USER': 'cltbld', 19:36:27 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1480649761.120091-1069115570', 19:36:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:27 INFO - '_': '/tools/buildbot/bin/python'} 19:36:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:28 INFO - Downloading/unpacking blobuploader==1.2.4 19:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:30 INFO - Downloading blobuploader-1.2.4.tar.gz 19:36:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:36:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:36:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:30 INFO - Downloading docopt-0.6.1.tar.gz 19:36:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:36:30 INFO - Installing collected packages: blobuploader, requests, docopt 19:36:30 INFO - Running setup.py install for blobuploader 19:36:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:36:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:36:30 INFO - Running setup.py install for requests 19:36:31 INFO - Running setup.py install for docopt 19:36:31 INFO - Successfully installed blobuploader requests docopt 19:36:31 INFO - Cleaning up... 19:36:31 INFO - Return code: 0 19:36:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd40f5b9e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbfbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd97130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe25fc0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe26ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe27350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1480649761.120091-1069115570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:36:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:36:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:36:31 INFO - Using env: {'DISPLAY': ':0', 19:36:31 INFO - 'HOME': '/home/cltbld', 19:36:31 INFO - 'LANG': 'en_US.UTF-8', 19:36:31 INFO - 'LANGUAGE': 'en_US:en', 19:36:31 INFO - 'LOGNAME': 'cltbld', 19:36:31 INFO - 'MAIL': '/var/mail/cltbld', 19:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:31 INFO - 'MOZ_NO_REMOTE': '1', 19:36:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:31 INFO - 'NO_EM_RESTART': '1', 19:36:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:31 INFO - 'PWD': '/builds/slave/test', 19:36:31 INFO - 'SHELL': '/bin/bash', 19:36:31 INFO - 'SHLVL': '1', 19:36:31 INFO - 'TERM': 'linux', 19:36:31 INFO - 'TMOUT': '86400', 19:36:31 INFO - 'USER': 'cltbld', 19:36:31 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1480649761.120091-1069115570', 19:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:31 INFO - '_': '/tools/buildbot/bin/python'} 19:36:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:36:31 INFO - Running setup.py (path:/tmp/pip-7n9RnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:36:31 INFO - Running setup.py (path:/tmp/pip-dA1v34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:36:31 INFO - Running setup.py (path:/tmp/pip-VFbdhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:36:31 INFO - Running setup.py (path:/tmp/pip-52ShrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:36:31 INFO - Running setup.py (path:/tmp/pip-ejYzd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:36:31 INFO - Running setup.py (path:/tmp/pip-oJNaEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:36:32 INFO - Running setup.py (path:/tmp/pip-m4cZdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:36:32 INFO - Running setup.py (path:/tmp/pip-8ljiDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:36:32 INFO - Running setup.py (path:/tmp/pip-Dv7z8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:36:32 INFO - Running setup.py (path:/tmp/pip-vJkmED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:36:32 INFO - Running setup.py (path:/tmp/pip-trT1FN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:36:32 INFO - Running setup.py (path:/tmp/pip-ez2O_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:36:32 INFO - Running setup.py (path:/tmp/pip-yLPca4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:36:32 INFO - Running setup.py (path:/tmp/pip-61UL0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:36:32 INFO - Running setup.py (path:/tmp/pip-zuEvF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:36:32 INFO - Running setup.py (path:/tmp/pip-4F6NJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:36:32 INFO - Running setup.py (path:/tmp/pip-D4LQzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:36:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:36:32 INFO - Running setup.py install for manifestparser 19:36:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:36:32 INFO - Running setup.py install for mozcrash 19:36:33 INFO - Running setup.py install for mozdebug 19:36:33 INFO - Running setup.py install for mozdevice 19:36:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:36:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:36:33 INFO - Running setup.py install for mozfile 19:36:33 INFO - Running setup.py install for mozhttpd 19:36:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:36:33 INFO - Running setup.py install for mozinfo 19:36:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:36:33 INFO - Running setup.py install for mozInstall 19:36:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:36:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:36:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:36:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:36:33 INFO - Running setup.py install for mozleak 19:36:33 INFO - Running setup.py install for mozlog 19:36:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:36:33 INFO - Running setup.py install for moznetwork 19:36:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:36:34 INFO - Running setup.py install for mozprocess 19:36:34 INFO - Running setup.py install for mozprofile 19:36:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:36:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:36:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:36:34 INFO - Running setup.py install for mozrunner 19:36:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:36:34 INFO - Running setup.py install for mozscreenshot 19:36:34 INFO - Running setup.py install for moztest 19:36:34 INFO - Running setup.py install for mozversion 19:36:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:36:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:36:34 INFO - Cleaning up... 19:36:34 INFO - Return code: 0 19:36:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd40f5b9e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbfbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd97130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe25fc0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe26ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe27350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1480649761.120091-1069115570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:36:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:36:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:36:34 INFO - Using env: {'DISPLAY': ':0', 19:36:34 INFO - 'HOME': '/home/cltbld', 19:36:34 INFO - 'LANG': 'en_US.UTF-8', 19:36:34 INFO - 'LANGUAGE': 'en_US:en', 19:36:34 INFO - 'LOGNAME': 'cltbld', 19:36:34 INFO - 'MAIL': '/var/mail/cltbld', 19:36:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:34 INFO - 'MOZ_NO_REMOTE': '1', 19:36:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:34 INFO - 'NO_EM_RESTART': '1', 19:36:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:34 INFO - 'PWD': '/builds/slave/test', 19:36:34 INFO - 'SHELL': '/bin/bash', 19:36:34 INFO - 'SHLVL': '1', 19:36:34 INFO - 'TERM': 'linux', 19:36:34 INFO - 'TMOUT': '86400', 19:36:34 INFO - 'USER': 'cltbld', 19:36:34 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1480649761.120091-1069115570', 19:36:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:34 INFO - '_': '/tools/buildbot/bin/python'} 19:36:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:36:34 INFO - Running setup.py (path:/tmp/pip-hExpZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:36:34 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:36:34 INFO - Running setup.py (path:/tmp/pip-2GF_5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:36:35 INFO - Running setup.py (path:/tmp/pip-fydyeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:36:35 INFO - Running setup.py (path:/tmp/pip-9pTrdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:36:35 INFO - Running setup.py (path:/tmp/pip-sSa8e1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:36:35 INFO - Running setup.py (path:/tmp/pip-fXmPJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:36:35 INFO - Running setup.py (path:/tmp/pip-YdgVpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:36:35 INFO - Running setup.py (path:/tmp/pip-2v7yCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:36:35 INFO - Running setup.py (path:/tmp/pip-sL7EI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:36:35 INFO - Running setup.py (path:/tmp/pip-1ThdoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:36:35 INFO - Running setup.py (path:/tmp/pip-WWeyzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:36:35 INFO - Running setup.py (path:/tmp/pip-W_mkb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:36:35 INFO - Running setup.py (path:/tmp/pip-MAicuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:36:35 INFO - Running setup.py (path:/tmp/pip-JCPRiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:36:35 INFO - Running setup.py (path:/tmp/pip-WERIgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:36:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:36:35 INFO - Running setup.py (path:/tmp/pip-ytP5NG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:36:36 INFO - Running setup.py (path:/tmp/pip-jvWREH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:36:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:38 INFO - Downloading blessings-1.6.tar.gz 19:36:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:36:38 INFO - Installing collected packages: blessings 19:36:38 INFO - Running setup.py install for blessings 19:36:38 INFO - Successfully installed blessings 19:36:38 INFO - Cleaning up... 19:36:38 INFO - Return code: 0 19:36:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:36:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:36:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:36:38 INFO - Reading from file tmpfile_stdout 19:36:38 INFO - Current package versions: 19:36:38 INFO - argparse == 1.2.1 19:36:38 INFO - blessings == 1.6 19:36:38 INFO - blobuploader == 1.2.4 19:36:38 INFO - docopt == 0.6.1 19:36:38 INFO - functools32 == 3.2.3-2 19:36:38 INFO - jsonschema == 2.5.1 19:36:38 INFO - manifestparser == 1.1 19:36:38 INFO - mozInstall == 1.12 19:36:38 INFO - mozcrash == 1.0 19:36:38 INFO - mozdebug == 0.1 19:36:38 INFO - mozdevice == 0.49 19:36:38 INFO - mozfile == 1.2 19:36:38 INFO - mozhttpd == 0.7 19:36:38 INFO - mozinfo == 0.9 19:36:38 INFO - mozleak == 0.1 19:36:38 INFO - mozlog == 3.4 19:36:38 INFO - moznetwork == 0.27 19:36:38 INFO - mozprocess == 0.23 19:36:38 INFO - mozprofile == 0.28 19:36:38 INFO - mozrunner == 6.13 19:36:38 INFO - mozscreenshot == 0.1 19:36:38 INFO - mozsystemmonitor == 0.3 19:36:38 INFO - moztest == 0.7 19:36:38 INFO - mozversion == 1.4 19:36:38 INFO - psutil == 3.1.1 19:36:38 INFO - requests == 1.2.3 19:36:38 INFO - wsgiref == 0.1.2 19:36:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd40f5b9e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbfbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd97130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe25fc0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe26ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe27350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1480649761.120091-1069115570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:36:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:36:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:36:38 INFO - Using env: {'DISPLAY': ':0', 19:36:38 INFO - 'HOME': '/home/cltbld', 19:36:38 INFO - 'LANG': 'en_US.UTF-8', 19:36:38 INFO - 'LANGUAGE': 'en_US:en', 19:36:38 INFO - 'LOGNAME': 'cltbld', 19:36:38 INFO - 'MAIL': '/var/mail/cltbld', 19:36:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:38 INFO - 'MOZ_NO_REMOTE': '1', 19:36:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:38 INFO - 'NO_EM_RESTART': '1', 19:36:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:38 INFO - 'PWD': '/builds/slave/test', 19:36:38 INFO - 'SHELL': '/bin/bash', 19:36:38 INFO - 'SHLVL': '1', 19:36:38 INFO - 'TERM': 'linux', 19:36:38 INFO - 'TMOUT': '86400', 19:36:38 INFO - 'USER': 'cltbld', 19:36:38 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1480649761.120091-1069115570', 19:36:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:38 INFO - '_': '/tools/buildbot/bin/python'} 19:36:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:36:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:36:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:36:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:36:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:36:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:36:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:36:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:36:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:36:38 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:36:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:36:38 INFO - Cleaning up... 19:36:38 INFO - Return code: 0 19:36:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd40f5b9e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbfbb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd97130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe25fc0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe26ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe27350>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1480649761.120091-1069115570', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:36:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:36:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:36:38 INFO - Using env: {'DISPLAY': ':0', 19:36:38 INFO - 'HOME': '/home/cltbld', 19:36:38 INFO - 'LANG': 'en_US.UTF-8', 19:36:38 INFO - 'LANGUAGE': 'en_US:en', 19:36:38 INFO - 'LOGNAME': 'cltbld', 19:36:38 INFO - 'MAIL': '/var/mail/cltbld', 19:36:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:38 INFO - 'MOZ_NO_REMOTE': '1', 19:36:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:38 INFO - 'NO_EM_RESTART': '1', 19:36:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:38 INFO - 'PWD': '/builds/slave/test', 19:36:38 INFO - 'SHELL': '/bin/bash', 19:36:38 INFO - 'SHLVL': '1', 19:36:38 INFO - 'TERM': 'linux', 19:36:38 INFO - 'TMOUT': '86400', 19:36:38 INFO - 'USER': 'cltbld', 19:36:38 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1480649761.120091-1069115570', 19:36:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:38 INFO - '_': '/tools/buildbot/bin/python'} 19:36:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:36:39 INFO - Cleaning up... 19:36:39 INFO - Return code: 0 19:36:39 INFO - Running post-action listener: _resource_record_post_action 19:36:39 INFO - Running post-action listener: _start_resource_monitoring 19:36:39 INFO - Starting resource monitoring. 19:36:39 INFO - [mozharness: 2016-12-02 03:36:39.082190Z] Finished create-virtualenv step (success) 19:36:39 INFO - [mozharness: 2016-12-02 03:36:39.082656Z] Running install step. 19:36:39 INFO - Running pre-action listener: _resource_record_pre_action 19:36:39 INFO - Running main action method: install 19:36:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:36:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:36:39 INFO - Reading from file tmpfile_stdout 19:36:39 INFO - Detecting whether we're running mozinstall >=1.0... 19:36:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:36:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:36:39 INFO - Reading from file tmpfile_stdout 19:36:39 INFO - Output received: 19:36:39 INFO - Usage: mozinstall [options] installer 19:36:39 INFO - Options: 19:36:39 INFO - -h, --help show this help message and exit 19:36:39 INFO - -d DEST, --destination=DEST 19:36:39 INFO - Directory to install application into. [default: 19:36:39 INFO - "/builds/slave/test"] 19:36:39 INFO - --app=APP Application being installed. [default: firefox] 19:36:39 INFO - mkdir: /builds/slave/test/build/application 19:36:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:36:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:36:55 INFO - Reading from file tmpfile_stdout 19:36:55 INFO - Output received: 19:36:55 INFO - /builds/slave/test/build/application/firefox/firefox 19:36:55 INFO - Running post-action listener: _resource_record_post_action 19:36:55 INFO - [mozharness: 2016-12-02 03:36:55.420936Z] Finished install step (success) 19:36:55 INFO - [mozharness: 2016-12-02 03:36:55.421176Z] Running run-tests step. 19:36:55 INFO - Running pre-action listener: _resource_record_pre_action 19:36:55 INFO - Running main action method: run_tests 19:36:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:36:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:36:55 INFO - Python 2.7.3 19:36:55 INFO - Return code: 0 19:36:55 INFO - grabbing minidump binary from tooltool 19:36:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:36:55 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe25fc0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe26ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe27350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:36:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:36:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:36:55 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:36:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:36:55 INFO - Return code: 0 19:36:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:36:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:36:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:36:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:36:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:36:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GgrvhpapRs-W8Wt5VY36Rw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:36:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GgrvhpapRs-W8Wt5VY36Rw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:36:55 INFO - Using env: {'DISPLAY': ':0', 19:36:55 INFO - 'HOME': '/home/cltbld', 19:36:55 INFO - 'LANG': 'en_US.UTF-8', 19:36:55 INFO - 'LANGUAGE': 'en_US:en', 19:36:55 INFO - 'LOGNAME': 'cltbld', 19:36:55 INFO - 'MAIL': '/var/mail/cltbld', 19:36:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:36:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:36:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:55 INFO - 'MOZ_NO_REMOTE': '1', 19:36:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:36:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:36:55 INFO - 'NO_EM_RESTART': '1', 19:36:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:36:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:55 INFO - 'PWD': '/builds/slave/test', 19:36:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:36:55 INFO - 'SHELL': '/bin/bash', 19:36:55 INFO - 'SHLVL': '1', 19:36:55 INFO - 'TERM': 'linux', 19:36:55 INFO - 'TMOUT': '86400', 19:36:55 INFO - 'USER': 'cltbld', 19:36:55 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1480649761.120091-1069115570', 19:36:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:55 INFO - '_': '/tools/buildbot/bin/python'} 19:36:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GgrvhpapRs-W8Wt5VY36Rw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:36:55 INFO - mozversion application_buildid: 20161201184344 19:36:55 INFO - mozversion application_changeset: 02fdf5d71d8e22357c82e0ab828544f4cd2f1250 19:36:55 INFO - mozversion application_display_name: Nightly 19:36:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:36:55 INFO - mozversion application_name: Firefox 19:36:55 INFO - mozversion application_remotingname: firefox 19:36:55 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 19:36:55 INFO - mozversion application_vendor: Mozilla 19:36:55 INFO - mozversion application_version: 53.0a1 19:36:55 INFO - mozversion platform_buildid: 20161201184344 19:36:55 INFO - mozversion platform_changeset: 02fdf5d71d8e22357c82e0ab828544f4cd2f1250 19:36:55 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 19:36:55 INFO - mozversion platform_version: 53.0a1 19:36:55 INFO - using testdate: 1480649815 19:36:55 INFO - actual date: 1480649815 19:36:55 INFO - starting webserver on 'localhost:35557' 19:36:55 INFO - SUITE-START | Running 2 tests 19:36:55 INFO - TEST-START | dromaeo_css 19:36:55 INFO - operating with platform_type : linux_ 19:36:55 INFO - Initialising browser for dromaeo_css test... 19:36:55 INFO - TEST-INFO | started process 23589 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXFMSiC/profile http://localhost:35557/getInfo.html) 19:37:00 INFO - PROCESS | 23589 | __metrics Screen width/height:1600/1200 19:37:00 INFO - PROCESS | 23589 | colorDepth:24 19:37:00 INFO - PROCESS | 23589 | Browser inner width/height: 1024/697 19:37:00 INFO - PROCESS | 23589 | __metrics 19:37:01 INFO - PROCESS | 23589 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:37:01 INFO - PROCESS | 23589 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:37:01 INFO - PROCESS | 23589 | console.error: PushService: 19:37:01 INFO - PROCESS | 23589 | stateChangeProcessEnqueue: Error transitioning state 19:37:01 INFO - PROCESS | 23589 | UnknownError 19:37:02 INFO - TEST-INFO | 23589: exit 0 19:37:02 INFO - Browser initialized. 19:37:02 INFO - Running cycle 1/1 for dromaeo_css test... 19:37:02 INFO - TEST-INFO | started process 23674 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXFMSiC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:37:15 INFO - PROCESS | 23674 | RSS: Main: 174710784 19:37:15 INFO - PROCESS | 23674 | 19:38:05 INFO - PROCESS | 23674 | 1480649885855 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:40:19 INFO - PROCESS | 23674 | Cycle 1(1): loaded http://localhost:35557/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35557/tests/dromaeo/cssquery-ext.html) 19:40:21 INFO - PROCESS | 23674 | RSS: Main: 320589824 19:40:21 INFO - PROCESS | 23674 | 19:43:24 INFO - PROCESS | 23674 | Cycle 1(1): loaded http://localhost:35557/tests/dromaeo/cssquery-ext.html (next: http://localhost:35557/tests/dromaeo/cssquery-jquery.html) 19:43:24 INFO - PROCESS | 23674 | RSS: Main: 275697664 19:43:24 INFO - PROCESS | 23674 | 19:46:27 INFO - PROCESS | 23674 | Cycle 1(1): loaded http://localhost:35557/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35557/tests/dromaeo/cssquery-mootools.html) 19:46:27 INFO - PROCESS | 23674 | RSS: Main: 254873600 19:46:27 INFO - PROCESS | 23674 | 19:49:29 INFO - PROCESS | 23674 | Cycle 1(1): loaded http://localhost:35557/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35557/tests/dromaeo/cssquery-prototype.html) 19:49:30 INFO - PROCESS | 23674 | RSS: Main: 235393024 19:49:30 INFO - PROCESS | 23674 | 19:52:33 INFO - PROCESS | 23674 | Cycle 1(1): loaded http://localhost:35557/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35557/tests/dromaeo/cssquery-yui.html) 19:52:34 INFO - PROCESS | 23674 | RSS: Main: 218304512 19:52:34 INFO - PROCESS | 23674 | 19:55:37 INFO - PROCESS | 23674 | Cycle 1(1): loaded http://localhost:35557/tests/dromaeo/cssquery-yui.html (next: http://localhost:35557/tests/dromaeo/cssquery-dojo.html) 19:55:37 INFO - PROCESS | 23674 | RSS: Main: 312463360 19:55:37 INFO - PROCESS | 23674 | 19:55:37 INFO - PROCESS | 23674 | __start_tp_report 19:55:37 INFO - PROCESS | 23674 | _x_x_mozilla_page_load 19:55:37 INFO - PROCESS | 23674 | _x_x_mozilla_page_load_details 19:55:37 INFO - PROCESS | 23674 | |i|pagename|runs| 19:55:37 INFO - PROCESS | 23674 | |0;dojo.html;2589.184406911823;2607.08751936822;2631.6973548041974;2644.1935209761027;2655.9468810623775;4556.134334476447;4590.954090459094;4710.599599034082;4727.66906316558;4737.928931066032;4647.883802904929;4669.813207471706;4692.202325604647;4742.288656701497;4742.383490146276;4257.850975215868;4277;4314.870553883388;4338.522762496123;4422.402975598286;4249.766262855542;4330.783460826962;4351.216780979423;4394.846180383687;4417.602415782579;4174.77038762868;4284.057507348379;4299.032717638537;4368.279233926399;4405;4206.810693518768;4250.171216612762;4255.63827074699;4257.808398622069;4259.616634502879;4245.724027938174;4269.573042695737;4276.5295817460055;4331.7184383015;4338.674599405026;4652.906941861178;4674.7428891410955;4686.08621318843;4697.906041879178;4737.123632128068;4851.34506841579;5020.77406516704;5023.547880690719;5024.748762561894;5078.4413714491375;4931.827386041507;4976.054549635558;4992.750362481897;5006.774695138691;5012.198048312289;4678.578927896506;4692.929606055912;4729.077829823186;4733.290006499053;4737.905241895142;5108.438071812097;5109.693418394908;5110.821121260738;5116.437191908887;5157.948420515747;4735.479097299294;4741.383620129361;4901.975490122527;4914.140025495524;4958.107540642647;4890.413150421972;4969.4782047884455;5015.598752099896;5026.648134630541;5098.209777484496;4907.509249075064;4916.287138364989;4916.852494425173;4920.6309526785635;4943.555080042814;4964.15609346412;4973.030259099441;4975.90048199034;4977.800887964513;5003.899922001539;4169.958300417018;4181.644560212355;4214.17823524416;4297.269464191095;4332.1119170569955;3729.738918275749;3742.6631603155847;3772.2832661794173;3773.1699026214187;3800.1449673823167;4375.059362237134;4375.256206444912;4378.4745830499905;4411.625011873963;4421.314696222091;4863.392075990501;5008.549230569266;5013.348264725562;5013.824516141917;5015.949840501621;4253.787310634456;4285.700000999963;4300.333448315516;4303.741775493418;4304.117655880537;4424.159409712144;4481.327800829901;4482.125985432809;4483.484399294058;4484.641228701761;4634.814607415733;4642.953570464388;4654.627629789541;4656.4412270527755;4660.231061874752;4947.505249475023;4969.155243608523;4973.030259099441;4979.178435558092;5013.373328333958;4721.220998535203;4749.786259618257;4751.714897106184;4764.8332308369045;4765.9046819064115;4910.582600479;4958.132326842716;4961.5286547777905;4965.702057876539;5006.524380183877;4915.336429582104;5019.548240658358;5028.673136246279;5030.170021946338;5064.341635587498;4872.561469467765;4873.390826146731;4907.165781817171;4918.95081049185;4973.229149481836;4928.186849169847;4931.038447502702;4937.28409380645;4940.357753492023;4975.6019518437715;4859.368282123442;4862.270659401118;4866.839794041605;4870.391201099863;4906.435759887516;4772.3557319761385;4825.9034819302715;4916.139675556692;4923.335349727741;4957.380327459067;4821.46963833985;4825.5898248649255;4829.96155826499;4868.561829435368;4880.292357608056 19:55:37 INFO - PROCESS | 23674 | |1;ext.html;501.90212908482846;510.7410233773747;516.1200153737877;528.5454509122154;555.6499405374614;27349.863250683742;37906.81046594767;38734.418983715266;38942.41586376203;41978.58021419785;38223.61776382235;38591.42112868309;38688.226235475275;38712;38998.32020157585;7372.7050917963215;7531.736389226378;7532.9246707532775;7537.51006184599;7537.736179233728;7165.319294667024;7433.665485053159;9554.423520119171;9800.166985806214;9834.950825245864;9815.803683926317;9888.456134912576;9896.505174741234;9898.35660682057;9912.702618921443;9814.656487022956;9871.309008369417;9879.407235565817;9880.160186384166;9885.159761420324;9702.514874256329;9773;9779.951100244452;9796.510174491319;9798.804023919482;36748;37077.81461092677;37090;37108.62891371106;37143.62856371429;2929.8974535891352;2934.9413011739857;2937.1482270141632;2942.7498662613702;3236.7572432067454;24908.750912491007;27970.440591188264;28098.157055288375;28293.29266768327;30452.39095218083;3044.269375349922;3335.499675048738;3364.6971772540346;3366.5286859839644;3394.2702319001287;245792;246018;247726;248570;249249.9999999982;53217.2017419739;53766.7311663447;53804;53819.73090134524;53880.46119538833;56196;56225.43774562202;56235.43764562302;56263;56274;12595.622131336075;12874.034447416481;12924.483020679067;12935.935320323339;12941.805872911913;9101.863472047924;9528.666496672584;10656.733581660521;10671.35971841692;10717.035466808025;16865.578360541083;17450.38923637692;17563.912180439016;18013;18198.909005454887;6307.5584709070845;6432.71052802625;6471.935280647227;6572.671366431659;6623.172103487064;750.7672621487357;869.2177040663327;869.6521391443473;904.9366544341965;928.4336554701626;26505.33736656599;27449.86275068612;27752.444951100864;27906;28178.85910570475;903.8824952756099;912.3659056955353;916.4501299220415;957.7126861941529;1016.0905989139678;14362.640933976525;14740.631484212767;14880.107193568421;14905.925470372578;14970.550883473514;372679;378999;379361;379903;381554;47604.7619761899;48307;48310.27534586984;48317.275240871415;48365;1112.6773235761539;1140.3500004997238;1146.2778449576713;1151.8272259161026;1155.4973586489905;25842.61236081498;26817.463650727266;27282.86358568274;27730.168094957182;27814.721852781215;41013.58986410098;41344.79327603343;41368.79315603403;41381.58618413777;41397.79301103596;302461;303843;304393;304552;304916;23377.532449351256;24103;24491.142810001566;30186.396272074875;30667.846660766554;38291.808540957114;40552.16336734326;40903.1819363617;44046.3393049111;45291.32063018991;34038.14904627404;34311.82844085863;34462.48306275358;34494.82752586221;34527.30945381028;35169.82415087908;35352.64647353596;35390.46914296339;35481.82259088688;35590.28819423649;33711.32577348488;34614.653853461146;35015.12462188364;35468;35575.46636800502;28894.566581500872;31658.208544786565;31716.682833172297;31908.202294942814;31926.201844954063;24397.3900652478;24509.79411852942;24680.753192467844;24956.750432495443;25144 19:55:37 INFO - PROCESS | 23674 | |2;jquery.html;327.6772379206483;340.04108414271735;347.648874636617;348.3138217711109;354.7747180540356;14426.350814213372;15737.291821868015;16302.184890755474;16446.259918303676;17157.485275441726;16254.268557914893;16288.918555407206;16791.83208167921;16798.41205557803;16821.83178168218;4825.396825396825;4875.683080599767;4996.500349965011;5049.2678561608545;5066.341375621182;4941.728204948727;4967.304577359173;4984.75076246188;4991.7504124793795;5005.349304590398;4783.856484305476;4941.258811178316;4962.776675049631;4967.925481117786;4997.625178111656;4896.167651499236;4937.185364414867;4937.876553086166;4941.283513890502;4948.505149485059;4337.50118736343;4369.4756629204385;4379;4385.364122202294;4458.665600079975;19787.31807796339;20051.298204562918;20108.79891201084;20194;20340.88125153116;1812.8096549862207;1894.5737209127974;1971.4775584470126;2171.945701357463;2350.1656911796235;12967;13004.804927926089;13125.803112953314;13237.139585926883;13860.58418247444;1642.7125253080662;1709.435886157565;1713.6572685462831;1752.7721396218537;1814.8911065336122;61725;63847;63979;65065;65443;8875.378723489423;9017.594208260643;9503.619855205714;9585.376950498196;9682.467464289532;12885.806712899313;12888.548900788428;12892.548760793516;12897.581266060726;12897.935510322575;6871.793846184622;7063.293670632896;7109.075820143452;7285.271472852673;7287.161976372679;6883.449324054063;6892;7073.292670732885;7075.2570980047385;7078.256783037707;5970.194023806731;6066.939330606726;6099.75600975956;6113.113598528189;6128;1539;1654.4044144108111;1700.8979461232366;1723.4915699868568;1735.496705955259;698.2528694297155;820.1552401026952;824.282873899711;836.0636087581947;851.2764150472049;16677.24952377146;16739;17161.313547458212;17539.386121485688;17658.735118973225;835.9038710548365;854.3549620036832;864.6627815152095;877.9078196789372;925.1257561604353;9307.953460232655;10156.572616956844;10177.338472999232;10191.694249172537;10265.332753371007;345199;346491;346709;347617;349046;66994.3300566988;67672.6616366915;67916.320836791;67994.66002669955;70273;844.932405407566;898.6585097662846;900.4417261298037;901.1439132823843;901.5717534171216;10681.786364272826;14218.644533886736;15227.695446090795;16173.838261617704;16378.918105409397;36466;37489.625103748614;37946.810265948494;38134.56788889013;38321.61678383181;46661.533384665716;47189;47755.28367074427;48120.759396204194;48587.75706121447;7140.214576396696;7187.7843664690145;7402.074740657418;7414.073240844895;7507.249275072449;8216.055153657406;10520.526576304237;11710.355930423908;11890;12227.938860305641;9756.658516952157;9818.263630227619;9942.105210531086;10190.745231369276;10728.892711073102;9612.279079068958;9934.105930466292;9960.750981225527;9993.200543956611;10149.594016239267;10141.391516509033;10149.594016239267;10464.63373781914;10540.367577945348;10984.670459886216;7185.167782215502;7304.707811687473;7315.707371705073;7417.629118543943;7766.184550622103;9506.619735210514;9560.139587437165;9770.36492627977;9999.800004000024;10675.409573883304 19:55:37 INFO - PROCESS | 23674 | |3;mootools.html;1330.3215360166316;1345.1122259308854;1414.6958403943156;1571.3950129200268;1630.3560093762956;6447.7743278985245;6830.453563714903;6837.521373503844;6841.3500717431825;6841.794746157617;5542.334919809628;5760.4815566599;6542.37847404497;6714.865702685944;6798.11624488817;2063.329417939172;2076.8546201765885;2087.9164833406644;2087.9791202088013;2098.26560703754;2067.1008111471556;2071.658176400892;2076.5431605046865;2101.05452546354;2102.4954011037394;1707.462149422934;1771.707668234746;1960.147335908884;2032.390282915127;2034.298167132337;2061.701053347271;2069.7619773725914;2070.523779530701;2073.9585208295825;2080.906359213824;2011.8289945354663;2085.447356450542;2100.0444797617047;2100.8004239597212;2103.0431153824975;6871.587704737732;7009.859802803915;7040.577565346044;7108.431325493948;7112.9644351778425;4058.5738497457933;4165.4584903962295;4176.812043458051;4179.644730197937;4181.560936101726;2611.2949503634104;2752.518309295885;2789.2608458758446;2804.803663743539;2806.1862060002577;853.6116067189414;883.5648021895739;902.6389444222298;906.8367693815111;931.3713243560569;8773.824523509558;8820.382573219877;8826.602802873886;8840.602172902234;8844.646214151491;3521.5245941798044;3645.799481028516;3709.146896213886;3711.4247291669835;3752.699784017272;7787;7801.4929029612895;7803;7809.180036096128;7814.921850781419;4118.794060296973;4119.0526178979;4121.423000779893;4122.0107174277955;4125;3709.109813644706;3740.63595792154;3763.9059023524633;3769.962300377016;3775.962240377561;3234.530993006001;3352.3295340931422;3361.0421030006332;3385.3906296866307;3417.179876829543;1091.645215305029;1100.1968562948932;1101.509828126492;1110.8278216876397;1119.7312644965314;571.1974675580816;654.0418287209261;744.9384626906744;773.2383602151876;794.0986979777994;4368.366586844953;4421.29259318514;4422.137683151819;4462.9776851116185;4558.566936141061;791.6991543213542;810.1452967119627;820.5240960243045;842.5323945210345;852.7441767469859;2979.716926891942;3053.8931137410086;3111.626604807392;3118.5166299223656;3124.8906288280255;7785.610719464004;7815.687372505036;8138.226868447488;8151.8777218341775;8174.877376839352;8344.41589088758;8351.123132071045;8356.791080222922;8359.205875441823;8366.205210504992;6502.479801615859;6652.301508341651;6670.366315200048;6690.297518760557;6697.665116744143;4500.572445617661;4561.63506919439;4760.428748550196;4776.617870570277;4940.382452193476;7470.365018973231;7583.393328533814;7747.535147891144;7765.301122898966;7823.882641760264;7845.215478452337;7888.48724832884;7932.286094251545;7960.562169080757;8012.759617211493;5845.620034697731;5938.138969849261;5959.523238140851;5963.731632076654;5966.433188847226;6058.697065146813;6230.314665386894;6261.436470717657;6314.305426403183;6374.840628984312;5839.8540036497725;5865.384134665969;5889.94110058894;5903.11453281994;5906.995810712103;5544.500994910478;5637.746301416528;5640.266765320482;5690.971545142248;5701.572382071278;5474.2062400950845;5532.419095995024;5536.307961504812;5536.307961504812;5536.335639723259;3877.5734669185804;3958.485396898385;3991.640752332304;3999.220152070435;4132.752034877917;4071.3892916062828;4096.508418989741;4110.630043296118;4174.123434078878;4214.072903961123 19:55:37 INFO - PROCESS | 23674 | |4;prototype.html;268.87228566430935;273.31261876380904;278.1738237434819;278.27786893012626;279.21679688473824;4807.951920480794;4811.5910147637405;4857.271409288608;4871.878203044921;4872.95231525222;4433.379326894237;4550;4558.84044058458;4569.131864945658;4809.302651115586;3553.626869178744;3572.4819901114324;3586.659267369596;3675.44868269759;3676.3750162472443;3653.671169594736;3668.192997540537;3675.3016926783826;3685.4656074869263;3687.8709245176424;3595.4247320428735;3694.743787112395;3695.205530810875;3703.777773333595;3728.6457786510236;3648.872289469869;3659.8536058557625;3673.651003154696;3697.0757310672334;3700.9259814803822;3233.062411900546;3235.8382080895863;3236.7410607151373;3247.886323978649;3248.1230067881775;4588;4623.768811559408;4647.512011238805;4658.417697787777;4663.347131401607;4064.5325787534516;4149.170165966789;4165.45849039626;4171.331467413059;4210.642095421893;4935.346658869283;4936.851894443173;4949.381327334083;4965.280034395028;4993.551869957708;3498.4752287156875;3512.8419221134855;3513.6486351364915;3513.683768460851;3520.102373894666;5015.774290156952;5185.351831021122;5193.195054766517;5219.295395121648;5221.921671174935;3579.552555930509;3596.2627661329366;3603.171270607775;3612.4942508048894;3613.4941108244866;3645.671889529902;3651.543557055368;3657.2868290683596;3657.341678497896;3663.816809159531;4183.4312132950145;4194.140201258735;4202.474690663667;4208.558101399309;4209.20025195218;4790.520947905251;4949.57928576075;4990.5508504234795;5010.949890501121;5072.847814565569;1226.7423840993313;1227.147132742753;1232.1128787273149;1233.6299110266884;1235.6663700800734;789.4513313247238;817.8854960305562;823.3989187892872;846.9364797640078;848.117957324388;4297.226499230169;4300.548442413501;4309.482862056573;4313.956860431355;4316.913661726748;4938.827141050046;4963.131451995886;4967.726775027409;4975.427825800007;5016.849494515171;4188.497380314382;4261.8051703372785;4302.526722060571;4308.80610372534;4310.978445107754;2608.3348746069632;2613.9869300653377;2621.125894985095;2645.1535508637435;2656.1500319897445;4626.779146009867;4652.487941419053;4666.906661866744;4679.181143299909;4717.433907931001;5049.419316778544;5126.436092029874;5135.897282054338;5146.794128234828;5161.870953226125;4902.583280421204;4918.237673160737;4920.3111564381015;4924.384451943507;4934.753262336869;5248.714065054086;5249.480249480194;5250.238715386324;5252.816151434681;5258.631895767259;4918.434135252057;5128.692278463304;5157.6647517911215;5160.509751573594;5166;4879.170541007966;4885.975570122127;4888.584470320063;4905.05143359599;4914.722172235173;3524.295140971867;3527.2063785648024;3530.6998905093355;3546.627604101532;3546.847274635805;5103.617228707788;5171.250168725589;5232.476752324737;5235.502627250557;5262.131748261494;5039.21892106724;5045.596352291881;5052.69683818972;5066.82266120684;5073.782292249907;5063.746812659426;5067.341245638191;5067.771950262173;5080.364954380702;5091.389033316026;4717.174494463524;4903.239997800347;4990.201567749143;5001.624878134227;5033.370828646419;4809.711417314972;4923.941352609207;4965.255211718271;5026.673266237683;5050.267711181785;4901.828436004866;4916.70499770015;4938.185199442052;4946.307516947558;4948 19:55:37 INFO - PROCESS | 23674 | |5;yui.html;607.3016031563699;622.9439350458459;626.4643729611182;630.747700919632;736.7421402509119;11769.293842369452;13093.410796514168;13708.451661933535;13739.244341561223;14203.92898035511;14136.293185340743;14172.574822755334;14285.500007499739;14324.498642547513;14371.71256574868;607.9817605471843;625.2059883947384;746.6154930210932;768.5964868444083;770.5261264322429;737.7712908998201;755.777045771496;765.3035737478896;766.1151370167438;767.9616019199018;805.7864665863551;806.0931452116369;809.9149589293128;810.3031393002013;810.4691427115249;624.7719582352454;641.8234985379012;800.7237503061464;801.0107517216234;801.2588355770889;565.7425871228622;581.354696287121;586.4165155670092;588.2999230915198;588.6821116597032;12736.363181840963;12764.617061488078;12780.488780448772;12780.872191278062;12781.360931953364;11618.128640351923;11716.179867409284;12175.08686848481;12179.573714920023;12468.688282793002;9195.632174713004;9789.461579613118;11861.703457413547;12267.38663066843;12482.188657737308;3930.823112959895;3939.881803545898;3945.1320709443876;4026.396040593905;4033.1328764315813;62466;62521.68739156321;63746;64233.67883160601;65512.67243663751;9618;9674.854877176847;9726.562304696306;9766.658166964122;10069.54687039085;19013.144408501652;19264.711029334572;19326.903365483366;19387.22451101968;19498.12258448373;6658.60048397088;6702.966485167543;6737.764178253738;6842.521023528305;6995.965020174866;3460.740444466675;3688.6495782900583;3718.0147260975864;3718.3492888744363;3739.2521495700967;2697.109953715269;2782.054101605464;2797.52442084842;2797.5244208484605;2801.551751719715;470.4683707410604;476.9046190761792;484.3799936081821;488.4017079078172;490.9337239472697;586.9501092407107;608.1394826320707;621.5245337316957;631.5295105146603;657.8980258060009;8174.67301307941;8204.917950820534;8211.876821847676;8284.08875023747;8453.15468453162;472.6384315998264;550.3533348315793;564.7627996241588;577.5754820207144;625.1966223402997;3937.8818635440985;3995.2808494471274;4026.516817981861;4158.098928268868;4310.482742070972;63795.68102159553;64559.354406456274;64730.352696473376;65115.348846510926;65442.67278663576;44313.335299970524;49244.75377623089;56212.15681764777;58042.12936805951;58138.127928081114;51371.48628513742;51891.740541297055;52389.21416178684;52476.47523524792;53422;7903.112181424875;7923.1680673530755;7936.841263174589;7970.1631328709655;8187.3040791531;34963.82518087393;35318.34906414961;35366.64633353736;36145.457818133276;37402.43896341503;42759.422941170276;49049.26426103683;49284.2607360897;49973;50145.24782128344;9918.256130790076;10125.64560240388;10218.744531386776;10231.232657550565;10269.229807764297;11877.22798018126;12483.31341776211;12781.8082728761;13356.198628082346;13664.312690133851;10007.849882251627;11849;11875.228110172811;12165.391730413621;12670.493180273055;11883.881161188623;11906.52373905034;12135.150539462153;12266.080043996557;12337;12457.252564846138;12542.874571254171;12722.427490762753;13445.932770336085;13571;10108;10143.594256229668;10199.745006374604;10238.283320167815;11096.056835168778;10398.58405663765;10684.732881678021;10820.729481763019;10904;10953.452327383759 19:55:37 INFO - PROCESS | 23674 | __end_tp_report 19:55:37 INFO - PROCESS | 23674 | __start_cc_report 19:55:37 INFO - PROCESS | 23674 | _x_x_mozilla_cycle_collect,1457 19:55:37 INFO - PROCESS | 23674 | __end_cc_report 19:55:37 INFO - PROCESS | 23674 | __startTimestamp1480650937432__endTimestamp 19:55:37 INFO - PROCESS | 23674 | 19:55:37 INFO - PROCESS | 23674 | ------- Summary: start ------- 19:55:37 INFO - PROCESS | 23674 | Number of tests: 6 19:55:37 INFO - PROCESS | 23674 | 19:55:37 INFO - PROCESS | 23674 | [#0] dojo.html Cycles:165 Average:4627.28 Median:4742.38 stddev:477.96 (10.1%) stddev-sans-first:451.90 19:55:37 INFO - PROCESS | 23674 | Values: 2589.2 2607.1 2631.7 2644.2 2655.9 4556.1 4591.0 4710.6 4727.7 4737.9 4647.9 4669.8 4692.2 4742.3 4742.4 4257.9 4277.0 4314.9 4338.5 4422.4 4249.8 4330.8 4351.2 4394.8 4417.6 4174.8 4284.1 4299.0 4368.3 4405.0 4206.8 4250.2 4255.6 4257.8 4259.6 4245.7 4269.6 4276.5 4331.7 4338.7 4652.9 4674.7 4686.1 4697.9 4737.1 4851.3 5020.8 5023.5 5024.7 5078.4 4931.8 4976.1 4992.8 5006.8 5012.2 4678.6 4692.9 4729.1 4733.3 4737.9 5108.4 5109.7 5110.8 5116.4 5157.9 4735.5 4741.4 4902.0 4914.1 4958.1 4890.4 4969.5 5015.6 5026.6 5098.2 4907.5 4916.3 4916.9 4920.6 4943.6 4964.2 4973.0 4975.9 4977.8 5003.9 4170.0 4181.6 4214.2 4297.3 4332.1 3729.7 3742.7 3772.3 3773.2 3800.1 4375.1 4375.3 4378.5 4411.6 4421.3 4863.4 5008.5 5013.3 5013.8 5015.9 4253.8 4285.7 4300.3 4303.7 4304.1 4424.2 4481.3 4482.1 4483.5 4484.6 4634.8 4643.0 4654.6 4656.4 4660.2 4947.5 4969.2 4973.0 4979.2 5013.4 4721.2 4749.8 4751.7 4764.8 4765.9 4910.6 4958.1 4961.5 4965.7 5006.5 4915.3 5019.5 5028.7 5030.2 5064.3 4872.6 4873.4 4907.2 4919.0 4973.2 4928.2 4931.0 4937.3 4940.4 4975.6 4859.4 4862.3 4866.8 4870.4 4906.4 4772.4 4825.9 4916.1 4923.3 4957.4 4821.5 4825.6 4830.0 4868.6 4880.3 19:55:37 INFO - PROCESS | 23674 | 19:55:37 INFO - PROCESS | 23674 | [#1] ext.html Cycles:180 Average:46418.62 Median:36912.91 stddev:82724.20 (224.1%) stddev-sans-first:82884.42 19:55:37 INFO - PROCESS | 23674 | Values: 501.9 510.7 516.1 528.5 555.6 27349.9 37906.8 38734.4 38942.4 41978.6 38223.6 38591.4 38688.2 38712.0 38998.3 7372.7 7531.7 7532.9 7537.5 7537.7 7165.3 7433.7 9554.4 9800.2 9835.0 9815.8 9888.5 9896.5 9898.4 9912.7 9814.7 9871.3 9879.4 9880.2 9885.2 9702.5 9773.0 9780.0 9796.5 9798.8 36748.0 37077.8 37090.0 37108.6 37143.6 2929.9 2934.9 2937.1 2942.7 3236.8 24908.8 27970.4 28098.2 28293.3 30452.4 3044.3 3335.5 3364.7 3366.5 3394.3 245792.0 246018.0 247726.0 248570.0 249250.0 53217.2 53766.7 53804.0 53819.7 53880.5 56196.0 56225.4 56235.4 56263.0 56274.0 12595.6 12874.0 12924.5 12935.9 12941.8 9101.9 9528.7 10656.7 10671.4 10717.0 16865.6 17450.4 17563.9 18013.0 18198.9 6307.6 6432.7 6471.9 6572.7 6623.2 750.8 869.2 869.7 904.9 928.4 26505.3 27449.9 27752.4 27906.0 28178.9 903.9 912.4 916.5 957.7 1016.1 14362.6 14740.6 14880.1 14905.9 14970.6 372679.0 378999.0 379361.0 379903.0 381554.0 47604.8 48307.0 48310.3 48317.3 48365.0 1112.7 1140.4 1146.3 1151.8 1155.5 25842.6 26817.5 27282.9 27730.2 27814.7 41013.6 41344.8 41368.8 41381.6 41397.8 302461.0 303843.0 304393.0 304552.0 304916.0 23377.5 24103.0 24491.1 30186.4 30667.8 38291.8 40552.2 40903.2 44046.3 45291.3 34038.1 34311.8 34462.5 34494.8 34527.3 35169.8 35352.6 35390.5 35481.8 35590.3 33711.3 34614.7 35015.1 35468.0 35575.5 28894.6 31658.2 31716.7 31908.2 31926.2 24397.4 24509.8 24680.8 24956.8 25144.0 19:55:37 INFO - PROCESS | 23674 | 19:55:37 INFO - PROCESS | 23674 | [#2] jquery.html Cycles:180 Average:22587.78 Median:26452.31 stddev:57258.43 (216.5%) stddev-sans-first:57394.66 19:55:37 INFO - PROCESS | 23674 | Values: 327.7 340.0 347.6 348.3 354.8 14426.4 15737.3 16302.2 16446.3 17157.5 16254.3 16288.9 16791.8 16798.4 16821.8 4825.4 4875.7 4996.5 5049.3 5066.3 4941.7 4967.3 4984.8 4991.8 5005.3 4783.9 4941.3 4962.8 4967.9 4997.6 4896.2 4937.2 4937.9 4941.3 4948.5 4337.5 4369.5 4379.0 4385.4 4458.7 19787.3 20051.3 20108.8 20194.0 20340.9 1812.8 1894.6 1971.5 2171.9 2350.2 12967.0 13004.8 13125.8 13237.1 13860.6 1642.7 1709.4 1713.7 1752.8 1814.9 61725.0 63847.0 63979.0 65065.0 65443.0 8875.4 9017.6 9503.6 9585.4 9682.5 12885.8 12888.5 12892.5 12897.6 12897.9 6871.8 7063.3 7109.1 7285.3 7287.2 6883.4 6892.0 7073.3 7075.3 7078.3 5970.2 6066.9 6099.8 6113.1 6128.0 1539.0 1654.4 1700.9 1723.5 1735.5 698.3 820.2 824.3 836.1 851.3 16677.2 16739.0 17161.3 17539.4 17658.7 835.9 854.4 864.7 877.9 925.1 9308.0 10156.6 10177.3 10191.7 10265.3 345199.0 346491.0 346709.0 347617.0 349046.0 66994.3 67672.7 67916.3 67994.7 70273.0 844.9 898.7 900.4 901.1 901.6 10681.8 14218.6 15227.7 16173.8 16378.9 36466.0 37489.6 37946.8 38134.6 38321.6 46661.5 47189.0 47755.3 48120.8 48587.8 7140.2 7187.8 7402.1 7414.1 7507.2 8216.1 10520.5 11710.4 11890.0 12227.9 9756.7 9818.3 9942.1 10190.7 10728.9 9612.3 9934.1 9960.8 9993.2 10149.6 10141.4 10149.6 10464.6 10540.4 10984.7 7185.2 7304.7 7315.7 7417.6 7766.2 9506.6 9560.1 9770.4 9999.8 10675.4 19:55:37 INFO - PROCESS | 23674 | 19:55:37 INFO - PROCESS | 23674 | [#3] mootools.html Cycles:180 Average:4497.08 Median:5503.31 stddev:2410.03 (43.8%) stddev-sans-first:2405.04 19:55:37 INFO - PROCESS | 23674 | Values: 1330.3 1345.1 1414.7 1571.4 1630.4 6447.8 6830.5 6837.5 6841.4 6841.8 5542.3 5760.5 6542.4 6714.9 6798.1 2063.3 2076.9 2087.9 2088.0 2098.3 2067.1 2071.7 2076.5 2101.1 2102.5 1707.5 1771.7 1960.1 2032.4 2034.3 2061.7 2069.8 2070.5 2074.0 2080.9 2011.8 2085.4 2100.0 2100.8 2103.0 6871.6 7009.9 7040.6 7108.4 7113.0 4058.6 4165.5 4176.8 4179.6 4181.6 2611.3 2752.5 2789.3 2804.8 2806.2 853.6 883.6 902.6 906.8 931.4 8773.8 8820.4 8826.6 8840.6 8844.6 3521.5 3645.8 3709.1 3711.4 3752.7 7787.0 7801.5 7803.0 7809.2 7814.9 4118.8 4119.1 4121.4 4122.0 4125.0 3709.1 3740.6 3763.9 3770.0 3776.0 3234.5 3352.3 3361.0 3385.4 3417.2 1091.6 1100.2 1101.5 1110.8 1119.7 571.2 654.0 744.9 773.2 794.1 4368.4 4421.3 4422.1 4463.0 4558.6 791.7 810.1 820.5 842.5 852.7 2979.7 3053.9 3111.6 3118.5 3124.9 7785.6 7815.7 8138.2 8151.9 8174.9 8344.4 8351.1 8356.8 8359.2 8366.2 6502.5 6652.3 6670.4 6690.3 6697.7 4500.6 4561.6 4760.4 4776.6 4940.4 7470.4 7583.4 7747.5 7765.3 7823.9 7845.2 7888.5 7932.3 7960.6 8012.8 5845.6 5938.1 5959.5 5963.7 5966.4 6058.7 6230.3 6261.4 6314.3 6374.8 5839.9 5865.4 5889.9 5903.1 5907.0 5544.5 5637.7 5640.3 5691.0 5701.6 5474.2 5532.4 5536.3 5536.3 5536.3 3877.6 3958.5 3991.6 3999.2 4132.8 4071.4 4096.5 4110.6 4174.1 4214.1 19:55:37 INFO - PROCESS | 23674 | 19:55:37 INFO - PROCESS | 23674 | [#4] prototype.html Cycles:180 Average:4119.96 Median:4665.13 stddev:1218.70 (26.1%) stddev-sans-first:1187.35 19:55:37 INFO - PROCESS | 23674 | Values: 268.9 273.3 278.2 278.3 279.2 4808.0 4811.6 4857.3 4871.9 4873.0 4433.4 4550.0 4558.8 4569.1 4809.3 3553.6 3572.5 3586.7 3675.4 3676.4 3653.7 3668.2 3675.3 3685.5 3687.9 3595.4 3694.7 3695.2 3703.8 3728.6 3648.9 3659.9 3673.7 3697.1 3700.9 3233.1 3235.8 3236.7 3247.9 3248.1 4588.0 4623.8 4647.5 4658.4 4663.3 4064.5 4149.2 4165.5 4171.3 4210.6 4935.3 4936.9 4949.4 4965.3 4993.6 3498.5 3512.8 3513.6 3513.7 3520.1 5015.8 5185.4 5193.2 5219.3 5221.9 3579.6 3596.3 3603.2 3612.5 3613.5 3645.7 3651.5 3657.3 3657.3 3663.8 4183.4 4194.1 4202.5 4208.6 4209.2 4790.5 4949.6 4990.6 5010.9 5072.8 1226.7 1227.1 1232.1 1233.6 1235.7 789.5 817.9 823.4 846.9 848.1 4297.2 4300.5 4309.5 4314.0 4316.9 4938.8 4963.1 4967.7 4975.4 5016.8 4188.5 4261.8 4302.5 4308.8 4311.0 2608.3 2614.0 2621.1 2645.2 2656.2 4626.8 4652.5 4666.9 4679.2 4717.4 5049.4 5126.4 5135.9 5146.8 5161.9 4902.6 4918.2 4920.3 4924.4 4934.8 5248.7 5249.5 5250.2 5252.8 5258.6 4918.4 5128.7 5157.7 5160.5 5166.0 4879.2 4886.0 4888.6 4905.1 4914.7 3524.3 3527.2 3530.7 3546.6 3546.8 5103.6 5171.3 5232.5 5235.5 5262.1 5039.2 5045.6 5052.7 5066.8 5073.8 5063.7 5067.3 5067.8 5080.4 5091.4 4717.2 4903.2 4990.2 5001.6 5033.4 4809.7 4923.9 4965.3 5026.7 5050.3 4901.8 4916.7 4938.2 4946.3 4948.0 19:55:37 INFO - PROCESS | 23674 | 19:55:37 INFO - PROCESS | 23674 | [#5] yui.html Cycles:180 Average:14856.93 Median:471.55 stddev:18293.61 (3879.4%) stddev-sans-first:18313.63 19:55:37 INFO - PROCESS | 23674 | Values: 607.3 622.9 626.5 630.7 736.7 11769.3 13093.4 13708.5 13739.2 14203.9 14136.3 14172.6 14285.5 14324.5 14371.7 608.0 625.2 746.6 768.6 770.5 737.8 755.8 765.3 766.1 768.0 805.8 806.1 809.9 810.3 810.5 624.8 641.8 800.7 801.0 801.3 565.7 581.4 586.4 588.3 588.7 12736.4 12764.6 12780.5 12780.9 12781.4 11618.1 11716.2 12175.1 12179.6 12468.7 9195.6 9789.5 11861.7 12267.4 12482.2 3930.8 3939.9 3945.1 4026.4 4033.1 62466.0 62521.7 63746.0 64233.7 65512.7 9618.0 9674.9 9726.6 9766.7 10069.5 19013.1 19264.7 19326.9 19387.2 19498.1 6658.6 6703.0 6737.8 6842.5 6996.0 3460.7 3688.6 3718.0 3718.3 3739.3 2697.1 2782.1 2797.5 2797.5 2801.6 470.5 476.9 484.4 488.4 490.9 587.0 608.1 621.5 631.5 657.9 8174.7 8204.9 8211.9 8284.1 8453.2 472.6 550.4 564.8 577.6 625.2 3937.9 3995.3 4026.5 4158.1 4310.5 63795.7 64559.4 64730.4 65115.3 65442.7 44313.3 49244.8 56212.2 58042.1 58138.1 51371.5 51891.7 52389.2 52476.5 53422.0 7903.1 7923.2 7936.8 7970.2 8187.3 34963.8 35318.3 35366.6 36145.5 37402.4 42759.4 49049.3 49284.3 49973.0 50145.2 9918.3 10125.6 10218.7 10231.2 10269.2 11877.2 12483.3 12781.8 13356.2 13664.3 10007.8 11849.0 11875.2 12165.4 12670.5 11883.9 11906.5 12135.2 12266.1 12337.0 12457.3 12542.9 12722.4 13445.9 13571.0 10108.0 10143.6 10199.7 10238.3 11096.1 10398.6 10684.7 10820.7 10904.0 10953.5 19:55:37 INFO - PROCESS | 23674 | -------- Summary: end -------- 19:55:37 INFO - PROCESS | 23674 | 19:55:38 INFO - TEST-INFO | 23674: exit 0 19:55:38 INFO - TEST-OK | dromaeo_css | took 1122897ms 19:55:38 INFO - TEST-START | kraken 19:55:38 INFO - operating with platform_type : linux_ 19:55:38 INFO - Initialising browser for kraken test... 19:55:38 INFO - TEST-INFO | started process 23977 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbXL1yO/profile http://localhost:35557/getInfo.html) 19:55:43 INFO - PROCESS | 23977 | __metrics Screen width/height:1600/1200 19:55:43 INFO - PROCESS | 23977 | colorDepth:24 19:55:43 INFO - PROCESS | 23977 | Browser inner width/height: 1024/697 19:55:43 INFO - PROCESS | 23977 | __metrics 19:55:43 INFO - PROCESS | 23977 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:55:43 INFO - PROCESS | 23977 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:55:44 INFO - PROCESS | 23977 | console.error: PushService: 19:55:44 INFO - PROCESS | 23977 | stateChangeProcessEnqueue: Error transitioning state 19:55:44 INFO - PROCESS | 23977 | UnknownError 19:55:45 INFO - TEST-INFO | 23977: exit 0 19:55:45 INFO - Browser initialized. 19:55:45 INFO - Running cycle 1/1 for kraken test... 19:55:45 INFO - TEST-INFO | started process 24061 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbXL1yO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:55:57 INFO - PROCESS | 24061 | RSS: Main: 174931968 19:55:57 INFO - PROCESS | 24061 | 19:56:00 INFO - PROCESS | 24061 | Cycle 1(1): loaded http://localhost:35557/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35557/tests/kraken/driver.html?testName=audio-beat-detection) 19:56:01 INFO - PROCESS | 24061 | RSS: Main: 240279552 19:56:01 INFO - PROCESS | 24061 | 19:56:04 INFO - PROCESS | 24061 | Cycle 1(1): loaded http://localhost:35557/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35557/tests/kraken/driver.html?testName=audio-dft) 19:56:04 INFO - PROCESS | 24061 | RSS: Main: 218349568 19:56:04 INFO - PROCESS | 24061 | 19:56:07 INFO - PROCESS | 24061 | Cycle 1(1): loaded http://localhost:35557/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35557/tests/kraken/driver.html?testName=audio-fft) 19:56:08 INFO - PROCESS | 24061 | RSS: Main: 301854720 19:56:08 INFO - PROCESS | 24061 | 19:56:10 INFO - PROCESS | 24061 | Cycle 1(1): loaded http://localhost:35557/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35557/tests/kraken/driver.html?testName=audio-oscillator) 19:56:11 INFO - PROCESS | 24061 | RSS: Main: 212586496 19:56:11 INFO - PROCESS | 24061 | 19:56:13 INFO - PROCESS | 24061 | Cycle 1(1): loaded http://localhost:35557/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35557/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:56:14 INFO - PROCESS | 24061 | RSS: Main: 215105536 19:56:14 INFO - PROCESS | 24061 | 19:56:17 INFO - PROCESS | 24061 | Cycle 1(1): loaded http://localhost:35557/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35557/tests/kraken/driver.html?testName=imaging-darkroom) 19:56:17 INFO - PROCESS | 24061 | RSS: Main: 254238720 19:56:17 INFO - PROCESS | 24061 | 19:56:21 INFO - PROCESS | 24061 | Cycle 1(1): loaded http://localhost:35557/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35557/tests/kraken/driver.html?testName=imaging-desaturate) 19:56:22 INFO - PROCESS | 24061 | RSS: Main: 248889344 19:56:22 INFO - PROCESS | 24061 | 19:56:24 INFO - PROCESS | 24061 | Cycle 1(1): loaded http://localhost:35557/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35557/tests/kraken/driver.html?testName=json-parse-financial) 19:56:25 INFO - PROCESS | 24061 | RSS: Main: 250535936 19:56:25 INFO - PROCESS | 24061 | 19:56:27 INFO - PROCESS | 24061 | Cycle 1(1): loaded http://localhost:35557/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35557/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:56:27 INFO - PROCESS | 24061 | RSS: Main: 213680128 19:56:27 INFO - PROCESS | 24061 | 19:56:29 INFO - PROCESS | 24061 | Cycle 1(1): loaded http://localhost:35557/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35557/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:56:30 INFO - PROCESS | 24061 | RSS: Main: 221396992 19:56:30 INFO - PROCESS | 24061 | 19:56:32 INFO - PROCESS | 24061 | Cycle 1(1): loaded http://localhost:35557/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35557/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:56:33 INFO - PROCESS | 24061 | RSS: Main: 229347328 19:56:33 INFO - PROCESS | 24061 | 19:56:36 INFO - PROCESS | 24061 | Cycle 1(1): loaded http://localhost:35557/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35557/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:56:36 INFO - PROCESS | 24061 | RSS: Main: 237940736 19:56:36 INFO - PROCESS | 24061 | 19:56:39 INFO - PROCESS | 24061 | Cycle 1(1): loaded http://localhost:35557/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35557/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:56:40 INFO - PROCESS | 24061 | RSS: Main: 235274240 19:56:40 INFO - PROCESS | 24061 | 19:56:42 INFO - PROCESS | 24061 | Cycle 1(1): loaded http://localhost:35557/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35557/tests/kraken/driver.html?testName=ai-astar) 19:56:42 INFO - PROCESS | 24061 | RSS: Main: 285470720 19:56:42 INFO - PROCESS | 24061 | 19:56:42 INFO - PROCESS | 24061 | __start_tp_report 19:56:42 INFO - PROCESS | 24061 | _x_x_mozilla_page_load 19:56:42 INFO - PROCESS | 24061 | _x_x_mozilla_page_load_details 19:56:42 INFO - PROCESS | 24061 | |i|pagename|runs| 19:56:42 INFO - PROCESS | 24061 | |0;ai-astar;115;117;118;117;117;119;117;117;118;116 19:56:42 INFO - PROCESS | 24061 | |1;audio-beat-detection;160;128;127;166;128;128;127;129;158;130 19:56:42 INFO - PROCESS | 24061 | |2;audio-dft;161;162;162;163;164;163;163;164;162;162 19:56:42 INFO - PROCESS | 24061 | |3;audio-fft;75;78;77;119;77;77;79;78;106;76 19:56:42 INFO - PROCESS | 24061 | |4;audio-oscillator;85;84;115;84;89;84;101;83;84;119 19:56:42 INFO - PROCESS | 24061 | |5;imaging-gaussian-blur;118;117;117;116;116;116;117;118;118;118 19:56:42 INFO - PROCESS | 24061 | |6;imaging-darkroom;148;147;146;147;148;147;146;146;146;147 19:56:42 INFO - PROCESS | 24061 | |7;imaging-desaturate;95;96;95;96;95;95;95;95;95;95 19:56:42 INFO - PROCESS | 24061 | |8;json-parse-financial;64;68;63;63;64;65;65;64;64;65 19:56:42 INFO - PROCESS | 24061 | |9;json-stringify-tinderbox;66;66;66;67;66;66;66;69;66;68 19:56:42 INFO - PROCESS | 24061 | |10;stanford-crypto-aes;85;86;94;88;87;87;86;88;87;89 19:56:42 INFO - PROCESS | 24061 | |11;stanford-crypto-ccm;149;147;144;144;140;145;157;146;185;141 19:56:42 INFO - PROCESS | 24061 | |12;stanford-crypto-pbkdf2;183;180;182;179;175;183;182;184;177;178 19:56:42 INFO - PROCESS | 24061 | |13;stanford-crypto-sha256-iterative;72;73;71;77;75;73;73;72;76;73 19:56:42 INFO - PROCESS | 24061 | __end_tp_report 19:56:42 INFO - PROCESS | 24061 | __start_cc_report 19:56:42 INFO - PROCESS | 24061 | _x_x_mozilla_cycle_collect,1976 19:56:42 INFO - PROCESS | 24061 | __end_cc_report 19:56:42 INFO - PROCESS | 24061 | __startTimestamp1480651002654__endTimestamp 19:56:42 INFO - PROCESS | 24061 | 19:56:42 INFO - PROCESS | 24061 | ------- Summary: start ------- 19:56:42 INFO - PROCESS | 24061 | Number of tests: 14 19:56:42 INFO - PROCESS | 24061 | 19:56:42 INFO - PROCESS | 24061 | [#0] ai-astar Cycles:10 Average:117.10 Median:117.00 stddev:1.10 (0.9%) stddev-sans-first:0.87 19:56:42 INFO - PROCESS | 24061 | Values: 115.0 117.0 118.0 117.0 117.0 119.0 117.0 117.0 118.0 116.0 19:56:42 INFO - PROCESS | 24061 | 19:56:42 INFO - PROCESS | 24061 | [#1] audio-beat-detection Cycles:10 Average:138.10 Median:129.50 stddev:16.18 (12.5%) stddev-sans-first:15.09 19:56:42 INFO - PROCESS | 24061 | Values: 160.0 128.0 127.0 166.0 128.0 128.0 127.0 129.0 158.0 130.0 19:56:42 INFO - PROCESS | 24061 | 19:56:42 INFO - PROCESS | 24061 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:0.97 (0.6%) stddev-sans-first:0.83 19:56:42 INFO - PROCESS | 24061 | Values: 161.0 162.0 162.0 163.0 164.0 163.0 163.0 164.0 162.0 162.0 19:56:42 INFO - PROCESS | 24061 | 19:56:42 INFO - PROCESS | 24061 | [#3] audio-fft Cycles:10 Average:84.20 Median:77.00 stddev:15.27 (19.8%) stddev-sans-first:15.83 19:56:42 INFO - PROCESS | 24061 | Values: 75.0 78.0 77.0 119.0 77.0 77.0 79.0 78.0 106.0 76.0 19:56:42 INFO - PROCESS | 24061 | 19:56:42 INFO - PROCESS | 24061 | [#4] audio-oscillator Cycles:10 Average:92.80 Median:84.00 stddev:13.85 (16.5%) stddev-sans-first:14.40 19:56:42 INFO - PROCESS | 24061 | Values: 85.0 84.0 115.0 84.0 89.0 84.0 101.0 83.0 84.0 119.0 19:56:42 INFO - PROCESS | 24061 | 19:56:42 INFO - PROCESS | 24061 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.50 stddev:0.88 (0.7%) stddev-sans-first:0.87 19:56:42 INFO - PROCESS | 24061 | Values: 118.0 117.0 117.0 116.0 116.0 116.0 117.0 118.0 118.0 118.0 19:56:42 INFO - PROCESS | 24061 | 19:56:42 INFO - PROCESS | 24061 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 19:56:42 INFO - PROCESS | 24061 | Values: 148.0 147.0 146.0 147.0 148.0 147.0 146.0 146.0 146.0 147.0 19:56:42 INFO - PROCESS | 24061 | 19:56:42 INFO - PROCESS | 24061 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 19:56:42 INFO - PROCESS | 24061 | Values: 95.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 19:56:42 INFO - PROCESS | 24061 | 19:56:42 INFO - PROCESS | 24061 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:64.50 stddev:1.43 (2.2%) stddev-sans-first:1.51 19:56:42 INFO - PROCESS | 24061 | Values: 64.0 68.0 63.0 63.0 64.0 65.0 65.0 64.0 64.0 65.0 19:56:42 INFO - PROCESS | 24061 | 19:56:42 INFO - PROCESS | 24061 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:66.00 stddev:1.07 (1.6%) stddev-sans-first:1.12 19:56:42 INFO - PROCESS | 24061 | Values: 66.0 66.0 66.0 67.0 66.0 66.0 66.0 69.0 66.0 68.0 19:56:42 INFO - PROCESS | 24061 | 19:56:42 INFO - PROCESS | 24061 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:87.50 stddev:2.50 (2.9%) stddev-sans-first:2.45 19:56:42 INFO - PROCESS | 24061 | Values: 85.0 86.0 94.0 88.0 87.0 87.0 86.0 88.0 87.0 89.0 19:56:42 INFO - PROCESS | 24061 | 19:56:42 INFO - PROCESS | 24061 | [#11] stanford-crypto-ccm Cycles:10 Average:149.80 Median:146.50 stddev:13.24 (9.0%) stddev-sans-first:14.04 19:56:42 INFO - PROCESS | 24061 | Values: 149.0 147.0 144.0 144.0 140.0 145.0 157.0 146.0 185.0 141.0 19:56:42 INFO - PROCESS | 24061 | 19:56:42 INFO - PROCESS | 24061 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.30 Median:182.00 stddev:2.98 (1.6%) stddev-sans-first:3.00 19:56:42 INFO - PROCESS | 24061 | Values: 183.0 180.0 182.0 179.0 175.0 183.0 182.0 184.0 177.0 178.0 19:56:42 INFO - PROCESS | 24061 | 19:56:42 INFO - PROCESS | 24061 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.50 Median:73.00 stddev:1.90 (2.6%) stddev-sans-first:1.94 19:56:42 INFO - PROCESS | 24061 | Values: 72.0 73.0 71.0 77.0 75.0 73.0 73.0 72.0 76.0 73.0 19:56:42 INFO - PROCESS | 24061 | -------- Summary: end -------- 19:56:42 INFO - PROCESS | 24061 | 19:56:43 INFO - TEST-INFO | 24061: exit 0 19:56:44 INFO - TEST-OK | kraken | took 65409ms 19:56:44 INFO - SUITE-END | took 1188s 19:56:44 INFO - Completed test suite (00:19:48) 19:56:44 INFO - javascript benchmark 19:56:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2589.184406911823, 2607.08751936822, 2631.6973548041974, 2644.1935209761027, 2655.9468810623775, 4556.134334476447, 4590.954090459094, 4710.599599034082, 4727.66906316558, 4737.928931066032, 4647.883802904929, 4669.813207471706, 4692.202325604647, 4742.288656701497, 4742.383490146276, 4257.850975215868, 4277.0, 4314.870553883388, 4338.522762496123, 4422.402975598286, 4249.766262855542, 4330.783460826962, 4351.216780979423, 4394.846180383687, 4417.602415782579, 4174.77038762868, 4284.057507348379, 4299.032717638537, 4368.279233926399, 4405.0, 4206.810693518768, 4250.171216612762, 4255.63827074699, 4257.808398622069, 4259.616634502879, 4245.724027938174, 4269.573042695737, 4276.5295817460055, 4331.7184383015, 4338.674599405026, 4652.906941861178, 4674.7428891410955, 4686.08621318843, 4697.906041879178, 4737.123632128068, 4851.34506841579, 5020.77406516704, 5023.547880690719, 5024.748762561894, 5078.4413714491375, 4931.827386041507, 4976.054549635558, 4992.750362481897, 5006.774695138691, 5012.198048312289, 4678.578927896506, 4692.929606055912, 4729.077829823186, 4733.290006499053, 4737.905241895142, 5108.438071812097, 5109.693418394908, 5110.821121260738, 5116.437191908887, 5157.948420515747, 4735.479097299294, 4741.383620129361, 4901.975490122527, 4914.140025495524, 4958.107540642647, 4890.413150421972, 4969.4782047884455, 5015.598752099896, 5026.648134630541, 5098.209777484496, 4907.509249075064, 4916.287138364989, 4916.852494425173, 4920.6309526785635, 4943.555080042814, 4964.15609346412, 4973.030259099441, 4975.90048199034, 4977.800887964513, 5003.899922001539, 4169.958300417018, 4181.644560212355, 4214.17823524416, 4297.269464191095, 4332.1119170569955, 3729.738918275749, 3742.6631603155847, 3772.2832661794173, 3773.1699026214187, 3800.1449673823167, 4375.059362237134, 4375.256206444912, 4378.4745830499905, 4411.625011873963, 4421.314696222091, 4863.392075990501, 5008.549230569266, 5013.348264725562, 5013.824516141917, 5015.949840501621, 4253.787310634456, 4285.700000999963, 4300.333448315516, 4303.741775493418, 4304.117655880537, 4424.159409712144, 4481.327800829901, 4482.125985432809, 4483.484399294058, 4484.641228701761, 4634.814607415733, 4642.953570464388, 4654.627629789541, 4656.4412270527755, 4660.231061874752, 4947.505249475023, 4969.155243608523, 4973.030259099441, 4979.178435558092, 5013.373328333958, 4721.220998535203, 4749.786259618257, 4751.714897106184, 4764.8332308369045, 4765.9046819064115, 4910.582600479, 4958.132326842716, 4961.5286547777905, 4965.702057876539, 5006.524380183877, 4915.336429582104, 5019.548240658358, 5028.673136246279, 5030.170021946338, 5064.341635587498, 4872.561469467765, 4873.390826146731, 4907.165781817171, 4918.95081049185, 4973.229149481836, 4928.186849169847, 4931.038447502702, 4937.28409380645, 4940.357753492023, 4975.6019518437715, 4859.368282123442, 4862.270659401118, 4866.839794041605, 4870.391201099863, 4906.435759887516, 4772.3557319761385, 4825.9034819302715, 4916.139675556692, 4923.335349727741, 4957.380327459067, 4821.46963833985, 4825.5898248649255, 4829.96155826499, 4868.561829435368, 4880.292357608056], "value": 4597.1631433292505, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.90212908482846, 510.7410233773747, 516.1200153737877, 528.5454509122154, 555.6499405374614, 27349.863250683742, 37906.81046594767, 38734.418983715266, 38942.41586376203, 41978.58021419785, 38223.61776382235, 38591.42112868309, 38688.226235475275, 38712.0, 38998.32020157585, 7372.7050917963215, 7531.736389226378, 7532.9246707532775, 7537.51006184599, 7537.736179233728, 7165.319294667024, 7433.665485053159, 9554.423520119171, 9800.166985806214, 9834.950825245864, 9815.803683926317, 9888.456134912576, 9896.505174741234, 9898.35660682057, 9912.702618921443, 9814.656487022956, 9871.309008369417, 9879.407235565817, 9880.160186384166, 9885.159761420324, 9702.514874256329, 9773.0, 9779.951100244452, 9796.510174491319, 9798.804023919482, 36748.0, 37077.81461092677, 37090.0, 37108.62891371106, 37143.62856371429, 2929.8974535891352, 2934.9413011739857, 2937.1482270141632, 2942.7498662613702, 3236.7572432067454, 24908.750912491007, 27970.440591188264, 28098.157055288375, 28293.29266768327, 30452.39095218083, 3044.269375349922, 3335.499675048738, 3364.6971772540346, 3366.5286859839644, 3394.2702319001287, 245792.0, 246018.0, 247726.0, 248570.0, 249249.9999999982, 53217.2017419739, 53766.7311663447, 53804.0, 53819.73090134524, 53880.46119538833, 56196.0, 56225.43774562202, 56235.43764562302, 56263.0, 56274.0, 12595.622131336075, 12874.034447416481, 12924.483020679067, 12935.935320323339, 12941.805872911913, 9101.863472047924, 9528.666496672584, 10656.733581660521, 10671.35971841692, 10717.035466808025, 16865.578360541083, 17450.38923637692, 17563.912180439016, 18013.0, 18198.909005454887, 6307.5584709070845, 6432.71052802625, 6471.935280647227, 6572.671366431659, 6623.172103487064, 750.7672621487357, 869.2177040663327, 869.6521391443473, 904.9366544341965, 928.4336554701626, 26505.33736656599, 27449.86275068612, 27752.444951100864, 27906.0, 28178.85910570475, 903.8824952756099, 912.3659056955353, 916.4501299220415, 957.7126861941529, 1016.0905989139678, 14362.640933976525, 14740.631484212767, 14880.107193568421, 14905.925470372578, 14970.550883473514, 372679.0, 378999.0, 379361.0, 379903.0, 381554.0, 47604.7619761899, 48307.0, 48310.27534586984, 48317.275240871415, 48365.0, 1112.6773235761539, 1140.3500004997238, 1146.2778449576713, 1151.8272259161026, 1155.4973586489905, 25842.61236081498, 26817.463650727266, 27282.86358568274, 27730.168094957182, 27814.721852781215, 41013.58986410098, 41344.79327603343, 41368.79315603403, 41381.58618413777, 41397.79301103596, 302461.0, 303843.0, 304393.0, 304552.0, 304916.0, 23377.532449351256, 24103.0, 24491.142810001566, 30186.396272074875, 30667.846660766554, 38291.808540957114, 40552.16336734326, 40903.1819363617, 44046.3393049111, 45291.32063018991, 34038.14904627404, 34311.82844085863, 34462.48306275358, 34494.82752586221, 34527.30945381028, 35169.82415087908, 35352.64647353596, 35390.46914296339, 35481.82259088688, 35590.28819423649, 33711.32577348488, 34614.653853461146, 35015.12462188364, 35468.0, 35575.46636800502, 28894.566581500872, 31658.208544786565, 31716.682833172297, 31908.202294942814, 31926.201844954063, 24397.3900652478, 24509.79411852942, 24680.753192467844, 24956.750432495443, 25144.0], "value": 17399.84280548895, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.6772379206483, 340.04108414271735, 347.648874636617, 348.3138217711109, 354.7747180540356, 14426.350814213372, 15737.291821868015, 16302.184890755474, 16446.259918303676, 17157.485275441726, 16254.268557914893, 16288.918555407206, 16791.83208167921, 16798.41205557803, 16821.83178168218, 4825.396825396825, 4875.683080599767, 4996.500349965011, 5049.2678561608545, 5066.341375621182, 4941.728204948727, 4967.304577359173, 4984.75076246188, 4991.7504124793795, 5005.349304590398, 4783.856484305476, 4941.258811178316, 4962.776675049631, 4967.925481117786, 4997.625178111656, 4896.167651499236, 4937.185364414867, 4937.876553086166, 4941.283513890502, 4948.505149485059, 4337.50118736343, 4369.4756629204385, 4379.0, 4385.364122202294, 4458.665600079975, 19787.31807796339, 20051.298204562918, 20108.79891201084, 20194.0, 20340.88125153116, 1812.8096549862207, 1894.5737209127974, 1971.4775584470126, 2171.945701357463, 2350.1656911796235, 12967.0, 13004.804927926089, 13125.803112953314, 13237.139585926883, 13860.58418247444, 1642.7125253080662, 1709.435886157565, 1713.6572685462831, 1752.7721396218537, 1814.8911065336122, 61725.0, 63847.0, 63979.0, 65065.0, 65443.0, 8875.378723489423, 9017.594208260643, 9503.619855205714, 9585.376950498196, 9682.467464289532, 12885.806712899313, 12888.548900788428, 12892.548760793516, 12897.581266060726, 12897.935510322575, 6871.793846184622, 7063.293670632896, 7109.075820143452, 7285.271472852673, 7287.161976372679, 6883.449324054063, 6892.0, 7073.292670732885, 7075.2570980047385, 7078.256783037707, 5970.194023806731, 6066.939330606726, 6099.75600975956, 6113.113598528189, 6128.0, 1539.0, 1654.4044144108111, 1700.8979461232366, 1723.4915699868568, 1735.496705955259, 698.2528694297155, 820.1552401026952, 824.282873899711, 836.0636087581947, 851.2764150472049, 16677.24952377146, 16739.0, 17161.313547458212, 17539.386121485688, 17658.735118973225, 835.9038710548365, 854.3549620036832, 864.6627815152095, 877.9078196789372, 925.1257561604353, 9307.953460232655, 10156.572616956844, 10177.338472999232, 10191.694249172537, 10265.332753371007, 345199.0, 346491.0, 346709.0, 347617.0, 349046.0, 66994.3300566988, 67672.6616366915, 67916.320836791, 67994.66002669955, 70273.0, 844.932405407566, 898.6585097662846, 900.4417261298037, 901.1439132823843, 901.5717534171216, 10681.786364272826, 14218.644533886736, 15227.695446090795, 16173.838261617704, 16378.918105409397, 36466.0, 37489.625103748614, 37946.810265948494, 38134.56788889013, 38321.61678383181, 46661.533384665716, 47189.0, 47755.28367074427, 48120.759396204194, 48587.75706121447, 7140.214576396696, 7187.7843664690145, 7402.074740657418, 7414.073240844895, 7507.249275072449, 8216.055153657406, 10520.526576304237, 11710.355930423908, 11890.0, 12227.938860305641, 9756.658516952157, 9818.263630227619, 9942.105210531086, 10190.745231369276, 10728.892711073102, 9612.279079068958, 9934.105930466292, 9960.750981225527, 9993.200543956611, 10149.594016239267, 10141.391516509033, 10149.594016239267, 10464.63373781914, 10540.367577945348, 10984.670459886216, 7185.167782215502, 7304.707811687473, 7315.707371705073, 7417.629118543943, 7766.184550622103, 9506.619735210514, 9560.139587437165, 9770.36492627977, 9999.800004000024, 10675.409573883304], "value": 8023.208643958639, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1330.3215360166316, 1345.1122259308854, 1414.6958403943156, 1571.3950129200268, 1630.3560093762956, 6447.7743278985245, 6830.453563714903, 6837.521373503844, 6841.3500717431825, 6841.794746157617, 5542.334919809628, 5760.4815566599, 6542.37847404497, 6714.865702685944, 6798.11624488817, 2063.329417939172, 2076.8546201765885, 2087.9164833406644, 2087.9791202088013, 2098.26560703754, 2067.1008111471556, 2071.658176400892, 2076.5431605046865, 2101.05452546354, 2102.4954011037394, 1707.462149422934, 1771.707668234746, 1960.147335908884, 2032.390282915127, 2034.298167132337, 2061.701053347271, 2069.7619773725914, 2070.523779530701, 2073.9585208295825, 2080.906359213824, 2011.8289945354663, 2085.447356450542, 2100.0444797617047, 2100.8004239597212, 2103.0431153824975, 6871.587704737732, 7009.859802803915, 7040.577565346044, 7108.431325493948, 7112.9644351778425, 4058.5738497457933, 4165.4584903962295, 4176.812043458051, 4179.644730197937, 4181.560936101726, 2611.2949503634104, 2752.518309295885, 2789.2608458758446, 2804.803663743539, 2806.1862060002577, 853.6116067189414, 883.5648021895739, 902.6389444222298, 906.8367693815111, 931.3713243560569, 8773.824523509558, 8820.382573219877, 8826.602802873886, 8840.602172902234, 8844.646214151491, 3521.5245941798044, 3645.799481028516, 3709.146896213886, 3711.4247291669835, 3752.699784017272, 7787.0, 7801.4929029612895, 7803.0, 7809.180036096128, 7814.921850781419, 4118.794060296973, 4119.0526178979, 4121.423000779893, 4122.0107174277955, 4125.0, 3709.109813644706, 3740.63595792154, 3763.9059023524633, 3769.962300377016, 3775.962240377561, 3234.530993006001, 3352.3295340931422, 3361.0421030006332, 3385.3906296866307, 3417.179876829543, 1091.645215305029, 1100.1968562948932, 1101.509828126492, 1110.8278216876397, 1119.7312644965314, 571.1974675580816, 654.0418287209261, 744.9384626906744, 773.2383602151876, 794.0986979777994, 4368.366586844953, 4421.29259318514, 4422.137683151819, 4462.9776851116185, 4558.566936141061, 791.6991543213542, 810.1452967119627, 820.5240960243045, 842.5323945210345, 852.7441767469859, 2979.716926891942, 3053.8931137410086, 3111.626604807392, 3118.5166299223656, 3124.8906288280255, 7785.610719464004, 7815.687372505036, 8138.226868447488, 8151.8777218341775, 8174.877376839352, 8344.41589088758, 8351.123132071045, 8356.791080222922, 8359.205875441823, 8366.205210504992, 6502.479801615859, 6652.301508341651, 6670.366315200048, 6690.297518760557, 6697.665116744143, 4500.572445617661, 4561.63506919439, 4760.428748550196, 4776.617870570277, 4940.382452193476, 7470.365018973231, 7583.393328533814, 7747.535147891144, 7765.301122898966, 7823.882641760264, 7845.215478452337, 7888.48724832884, 7932.286094251545, 7960.562169080757, 8012.759617211493, 5845.620034697731, 5938.138969849261, 5959.523238140851, 5963.731632076654, 5966.433188847226, 6058.697065146813, 6230.314665386894, 6261.436470717657, 6314.305426403183, 6374.840628984312, 5839.8540036497725, 5865.384134665969, 5889.94110058894, 5903.11453281994, 5906.995810712103, 5544.500994910478, 5637.746301416528, 5640.266765320482, 5690.971545142248, 5701.572382071278, 5474.2062400950845, 5532.419095995024, 5536.307961504812, 5536.307961504812, 5536.335639723259, 3877.5734669185804, 3958.485396898385, 3991.640752332304, 3999.220152070435, 4132.752034877917, 4071.3892916062828, 4096.508418989741, 4110.630043296118, 4174.123434078878, 4214.072903961123], "value": 3691.0022901690822, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [268.87228566430935, 273.31261876380904, 278.1738237434819, 278.27786893012626, 279.21679688473824, 4807.951920480794, 4811.5910147637405, 4857.271409288608, 4871.878203044921, 4872.95231525222, 4433.379326894237, 4550.0, 4558.84044058458, 4569.131864945658, 4809.302651115586, 3553.626869178744, 3572.4819901114324, 3586.659267369596, 3675.44868269759, 3676.3750162472443, 3653.671169594736, 3668.192997540537, 3675.3016926783826, 3685.4656074869263, 3687.8709245176424, 3595.4247320428735, 3694.743787112395, 3695.205530810875, 3703.777773333595, 3728.6457786510236, 3648.872289469869, 3659.8536058557625, 3673.651003154696, 3697.0757310672334, 3700.9259814803822, 3233.062411900546, 3235.8382080895863, 3236.7410607151373, 3247.886323978649, 3248.1230067881775, 4588.0, 4623.768811559408, 4647.512011238805, 4658.417697787777, 4663.347131401607, 4064.5325787534516, 4149.170165966789, 4165.45849039626, 4171.331467413059, 4210.642095421893, 4935.346658869283, 4936.851894443173, 4949.381327334083, 4965.280034395028, 4993.551869957708, 3498.4752287156875, 3512.8419221134855, 3513.6486351364915, 3513.683768460851, 3520.102373894666, 5015.774290156952, 5185.351831021122, 5193.195054766517, 5219.295395121648, 5221.921671174935, 3579.552555930509, 3596.2627661329366, 3603.171270607775, 3612.4942508048894, 3613.4941108244866, 3645.671889529902, 3651.543557055368, 3657.2868290683596, 3657.341678497896, 3663.816809159531, 4183.4312132950145, 4194.140201258735, 4202.474690663667, 4208.558101399309, 4209.20025195218, 4790.520947905251, 4949.57928576075, 4990.5508504234795, 5010.949890501121, 5072.847814565569, 1226.7423840993313, 1227.147132742753, 1232.1128787273149, 1233.6299110266884, 1235.6663700800734, 789.4513313247238, 817.8854960305562, 823.3989187892872, 846.9364797640078, 848.117957324388, 4297.226499230169, 4300.548442413501, 4309.482862056573, 4313.956860431355, 4316.913661726748, 4938.827141050046, 4963.131451995886, 4967.726775027409, 4975.427825800007, 5016.849494515171, 4188.497380314382, 4261.8051703372785, 4302.526722060571, 4308.80610372534, 4310.978445107754, 2608.3348746069632, 2613.9869300653377, 2621.125894985095, 2645.1535508637435, 2656.1500319897445, 4626.779146009867, 4652.487941419053, 4666.906661866744, 4679.181143299909, 4717.433907931001, 5049.419316778544, 5126.436092029874, 5135.897282054338, 5146.794128234828, 5161.870953226125, 4902.583280421204, 4918.237673160737, 4920.3111564381015, 4924.384451943507, 4934.753262336869, 5248.714065054086, 5249.480249480194, 5250.238715386324, 5252.816151434681, 5258.631895767259, 4918.434135252057, 5128.692278463304, 5157.6647517911215, 5160.509751573594, 5166.0, 4879.170541007966, 4885.975570122127, 4888.584470320063, 4905.05143359599, 4914.722172235173, 3524.295140971867, 3527.2063785648024, 3530.6998905093355, 3546.627604101532, 3546.847274635805, 5103.617228707788, 5171.250168725589, 5232.476752324737, 5235.502627250557, 5262.131748261494, 5039.21892106724, 5045.596352291881, 5052.69683818972, 5066.82266120684, 5073.782292249907, 5063.746812659426, 5067.341245638191, 5067.771950262173, 5080.364954380702, 5091.389033316026, 4717.174494463524, 4903.239997800347, 4990.201567749143, 5001.624878134227, 5033.370828646419, 4809.711417314972, 4923.941352609207, 4965.255211718271, 5026.673266237683, 5050.267711181785, 4901.828436004866, 4916.70499770015, 4938.185199442052, 4946.307516947558, 4948.0], "value": 3725.278478463159, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.3016031563699, 622.9439350458459, 626.4643729611182, 630.747700919632, 736.7421402509119, 11769.293842369452, 13093.410796514168, 13708.451661933535, 13739.244341561223, 14203.92898035511, 14136.293185340743, 14172.574822755334, 14285.500007499739, 14324.498642547513, 14371.71256574868, 607.9817605471843, 625.2059883947384, 746.6154930210932, 768.5964868444083, 770.5261264322429, 737.7712908998201, 755.777045771496, 765.3035737478896, 766.1151370167438, 767.9616019199018, 805.7864665863551, 806.0931452116369, 809.9149589293128, 810.3031393002013, 810.4691427115249, 624.7719582352454, 641.8234985379012, 800.7237503061464, 801.0107517216234, 801.2588355770889, 565.7425871228622, 581.354696287121, 586.4165155670092, 588.2999230915198, 588.6821116597032, 12736.363181840963, 12764.617061488078, 12780.488780448772, 12780.872191278062, 12781.360931953364, 11618.128640351923, 11716.179867409284, 12175.08686848481, 12179.573714920023, 12468.688282793002, 9195.632174713004, 9789.461579613118, 11861.703457413547, 12267.38663066843, 12482.188657737308, 3930.823112959895, 3939.881803545898, 3945.1320709443876, 4026.396040593905, 4033.1328764315813, 62466.0, 62521.68739156321, 63746.0, 64233.67883160601, 65512.67243663751, 9618.0, 9674.854877176847, 9726.562304696306, 9766.658166964122, 10069.54687039085, 19013.144408501652, 19264.711029334572, 19326.903365483366, 19387.22451101968, 19498.12258448373, 6658.60048397088, 6702.966485167543, 6737.764178253738, 6842.521023528305, 6995.965020174866, 3460.740444466675, 3688.6495782900583, 3718.0147260975864, 3718.3492888744363, 3739.2521495700967, 2697.109953715269, 2782.054101605464, 2797.52442084842, 2797.5244208484605, 2801.551751719715, 470.4683707410604, 476.9046190761792, 484.3799936081821, 488.4017079078172, 490.9337239472697, 586.9501092407107, 608.1394826320707, 621.5245337316957, 631.5295105146603, 657.8980258060009, 8174.67301307941, 8204.917950820534, 8211.876821847676, 8284.08875023747, 8453.15468453162, 472.6384315998264, 550.3533348315793, 564.7627996241588, 577.5754820207144, 625.1966223402997, 3937.8818635440985, 3995.2808494471274, 4026.516817981861, 4158.098928268868, 4310.482742070972, 63795.68102159553, 64559.354406456274, 64730.352696473376, 65115.348846510926, 65442.67278663576, 44313.335299970524, 49244.75377623089, 56212.15681764777, 58042.12936805951, 58138.127928081114, 51371.48628513742, 51891.740541297055, 52389.21416178684, 52476.47523524792, 53422.0, 7903.112181424875, 7923.1680673530755, 7936.841263174589, 7970.1631328709655, 8187.3040791531, 34963.82518087393, 35318.34906414961, 35366.64633353736, 36145.457818133276, 37402.43896341503, 42759.422941170276, 49049.26426103683, 49284.2607360897, 49973.0, 50145.24782128344, 9918.256130790076, 10125.64560240388, 10218.744531386776, 10231.232657550565, 10269.229807764297, 11877.22798018126, 12483.31341776211, 12781.8082728761, 13356.198628082346, 13664.312690133851, 10007.849882251627, 11849.0, 11875.228110172811, 12165.391730413621, 12670.493180273055, 11883.881161188623, 11906.52373905034, 12135.150539462153, 12266.080043996557, 12337.0, 12457.252564846138, 12542.874571254171, 12722.427490762753, 13445.932770336085, 13571.0, 10108.0, 10143.594256229668, 10199.745006374604, 10238.283320167815, 11096.056835168778, 10398.58405663765, 10684.732881678021, 10820.729481763019, 10904.0, 10953.452327383759], "value": 6261.8851695969015, "unit": "score"}], "name": "dromaeo_css", "value": 6171.7416198797955, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 117.0, 118.0, 117.0, 117.0, 119.0, 117.0, 117.0, 118.0, 116.0], "value": 117.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 128.0, 127.0, 166.0, 128.0, 128.0, 127.0, 129.0, 158.0, 130.0], "value": 138.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 163.0, 164.0, 163.0, 163.0, 164.0, 162.0, 162.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 77.0, 119.0, 77.0, 77.0, 79.0, 78.0, 106.0, 76.0], "value": 84.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 115.0, 84.0, 89.0, 84.0, 101.0, 83.0, 84.0, 119.0], "value": 92.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 118.0, 118.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 147.0, 148.0, 147.0, 146.0, 146.0, 146.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 68.0, 63.0, 63.0, 64.0, 65.0, 65.0, 64.0, 64.0, 65.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 67.0, 66.0, 66.0, 66.0, 69.0, 66.0, 68.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 94.0, 88.0, 87.0, 87.0, 86.0, 88.0, 87.0, 89.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 144.0, 144.0, 140.0, 145.0, 157.0, 146.0, 185.0, 141.0], "value": 149.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 180.0, 182.0, 179.0, 175.0, 183.0, 182.0, 184.0, 177.0, 178.0], "value": 180.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 71.0, 77.0, 75.0, 73.0, 73.0, 72.0, 76.0, 73.0], "value": 73.5, "unit": "score"}], "name": "kraken", "value": 1576.3, "alertThreshold": 2.0}]} 19:56:44 INFO - Return code: 0 19:56:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:56:44 INFO - # TBPL SUCCESS # 19:56:44 INFO - Running post-action listener: _resource_record_post_action 19:56:44 INFO - [mozharness: 2016-12-02 03:56:44.483145Z] Finished run-tests step (success) 19:56:44 INFO - Running post-run listener: _resource_record_post_run 19:56:44 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 8192; Write bytes: 391249920; Read time: 200; Write time: 323492 19:56:44 INFO - TinderboxPrint: CPU usage
13.1% 19:56:44 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 200 19:56:44 INFO - TinderboxPrint: I/O write bytes / time
391,249,920 / 323,492 19:56:44 INFO - TinderboxPrint: CPU idle
8,356.5 (86.9%) 19:56:44 INFO - TinderboxPrint: CPU user
1,209.0 (12.6%) 19:56:44 INFO - TinderboxPrint: Swap in / out
0 / 0 19:56:44 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 103215104; Read time: 0; Write time: 78124 19:56:44 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 8192; Write bytes: 288034816; Read time: 200; Write time: 245368 19:56:45 INFO - Running post-run listener: _upload_blobber_files 19:56:45 INFO - Blob upload gear active. 19:56:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:56:45 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:56:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:56:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:56:45 INFO - (blobuploader) - INFO - Open directory for files ... 19:56:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:56:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:56:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:56:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:56:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:56:46 INFO - (blobuploader) - INFO - Done attempting. 19:56:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:56:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:56:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:56:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:56:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:56:50 INFO - (blobuploader) - INFO - Done attempting. 19:56:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:56:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:56:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:56:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:56:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:56:51 INFO - (blobuploader) - INFO - Done attempting. 19:56:51 INFO - (blobuploader) - INFO - Iteration through files over. 19:56:51 INFO - Return code: 0 19:56:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:56:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:56:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b97ca6be4341f6110788bcae868eb5c49e6d57f8ca90a659cbdbe0f48e9dcd32828cf28d8ca2f67183d03b7628df255631b730fbe5d0216cc4bbfcd44ec20190", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/81a25072f765c5cf19b9549f8142c7907595d343cb91fa677316f3f25e3639a14f65d6e1497855797260c1387e40d962cd2dd5a537f62559ffb84debff6581d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3c8a874faa4fb2d55bfa80fbbfd6bb711d52e5d149dfa2e699356eef31cf24504e7550521875b02c3bef18a67e6e8fc5c141e745057850f794b6b4244170346b"} 19:56:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:56:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:56:51 INFO - Contents: 19:56:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b97ca6be4341f6110788bcae868eb5c49e6d57f8ca90a659cbdbe0f48e9dcd32828cf28d8ca2f67183d03b7628df255631b730fbe5d0216cc4bbfcd44ec20190", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/81a25072f765c5cf19b9549f8142c7907595d343cb91fa677316f3f25e3639a14f65d6e1497855797260c1387e40d962cd2dd5a537f62559ffb84debff6581d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3c8a874faa4fb2d55bfa80fbbfd6bb711d52e5d149dfa2e699356eef31cf24504e7550521875b02c3bef18a67e6e8fc5c141e745057850f794b6b4244170346b"} 19:56:51 INFO - Running post-run listener: copy_logs_to_upload_dir 19:56:51 INFO - Copying logs to upload dir... 19:56:51 INFO - mkdir: /builds/slave/test/build/upload/logs 19:56:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.485359 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-12-01 19:56:50.568057) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-01 19:56:50.572722) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1480649761.120091-1069115570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b97ca6be4341f6110788bcae868eb5c49e6d57f8ca90a659cbdbe0f48e9dcd32828cf28d8ca2f67183d03b7628df255631b730fbe5d0216cc4bbfcd44ec20190", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/81a25072f765c5cf19b9549f8142c7907595d343cb91fa677316f3f25e3639a14f65d6e1497855797260c1387e40d962cd2dd5a537f62559ffb84debff6581d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3c8a874faa4fb2d55bfa80fbbfd6bb711d52e5d149dfa2e699356eef31cf24504e7550521875b02c3bef18a67e6e8fc5c141e745057850f794b6b4244170346b"} build_url:https://queue.taskcluster.net/v1/task/GgrvhpapRs-W8Wt5VY36Rw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011649 build_url: 'https://queue.taskcluster.net/v1/task/GgrvhpapRs-W8Wt5VY36Rw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b97ca6be4341f6110788bcae868eb5c49e6d57f8ca90a659cbdbe0f48e9dcd32828cf28d8ca2f67183d03b7628df255631b730fbe5d0216cc4bbfcd44ec20190", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/81a25072f765c5cf19b9549f8142c7907595d343cb91fa677316f3f25e3639a14f65d6e1497855797260c1387e40d962cd2dd5a537f62559ffb84debff6581d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3c8a874faa4fb2d55bfa80fbbfd6bb711d52e5d149dfa2e699356eef31cf24504e7550521875b02c3bef18a67e6e8fc5c141e745057850f794b6b4244170346b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-01 19:56:50.598018) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 19:56:50.598372) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1480649761.120091-1069115570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004440 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-01 19:56:50.684327) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-01 19:56:50.684661) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-01 19:56:50.684999) ========= ========= Total master_lag: 0.16 =========