builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-045 starttime: 1474022004.53 results: success (0) buildid: 20160916004005 builduid: 75880864348849c486b8ac5d7bccb1f5 revision: 2c332306c030ca66df397155349cb5dd61165f69 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-16 03:33:24.535461) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-16 03:33:24.536435) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-16 03:33:24.537087) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-16 03:33:24.555924) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-16 03:33:24.556247) ========= 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=4300f881736b422476174874000001bc-1474022003.178916-1333656674 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-16 03:33:24-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.2M=0s 2016-09-16 03:33:24 (41.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116070 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-16 03:33:24.689572) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-16 03:33:24.690387) ========= 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=4300f881736b422476174874000001bc-1474022003.178916-1333656674 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019048 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-16 03:33:24.743116) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-16 03:33:24.743491) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2c332306c030ca66df397155349cb5dd61165f69 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2c332306c030ca66df397155349cb5dd61165f69 --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=4300f881736b422476174874000001bc-1474022003.178916-1333656674 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-16 03:33:25,101 truncating revision to first 12 chars 2016-09-16 03:33:25,102 Setting DEBUG logging. 2016-09-16 03:33:25,102 attempt 1/10 2016-09-16 03:33:25,102 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2c332306c030?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-16 03:33:25,827 unpacking tar archive at: mozilla-aurora-2c332306c030/testing/mozharness/ program finished with exit code 0 elapsedTime=1.043629 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-16 03:33:25.801051) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-16 03:33:25.801423) ========= script_repo_revision: 2c332306c030ca66df397155349cb5dd61165f69 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-16 03:33:25.801858) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-16 03:33:25.802127) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-16 03:33:25.813318) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 57 secs) (at 2016-09-16 03:33:25.813829) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=4300f881736b422476174874000001bc-1474022003.178916-1333656674 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:33:26 INFO - MultiFileLogger online at 20160916 03:33:26 in /builds/slave/test 03:33:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:33:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:33:26 INFO - {'append_to_log': False, 03:33:26 INFO - 'base_work_dir': '/builds/slave/test', 03:33:26 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:33:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:33:26 INFO - 'branch': 'Mozilla-Aurora', 03:33:26 INFO - 'buildbot_json_path': 'buildprops.json', 03:33:26 INFO - 'config_files': ('talos/linux_config.py',), 03:33:26 INFO - 'default_actions': ('clobber', 03:33:26 INFO - 'read-buildbot-config', 03:33:26 INFO - 'download-and-extract', 03:33:26 INFO - 'populate-webroot', 03:33:26 INFO - 'create-virtualenv', 03:33:26 INFO - 'install', 03:33:26 INFO - 'run-tests'), 03:33:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:33:26 INFO - 'download_minidump_stackwalk': True, 03:33:26 INFO - 'download_symbols': 'ondemand', 03:33:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:33:26 INFO - 'tooltool.py': '/tools/tooltool.py', 03:33:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:33:26 INFO - '/tools/misc-python/virtualenv.py')}, 03:33:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:33:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:33:26 INFO - 'installer_path': 'installer.exe', 03:33:26 INFO - 'log_level': 'info', 03:33:26 INFO - 'log_name': 'talos', 03:33:26 INFO - 'log_to_console': True, 03:33:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:33:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:33:26 INFO - 'opt_config_files': (), 03:33:26 INFO - 'pip_index': False, 03:33:26 INFO - 'sps_profile': False, 03:33:26 INFO - 'sps_profile_interval': 0, 03:33:26 INFO - 'suite': 'dromaeojs', 03:33:26 INFO - 'system_bits': '32', 03:33:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:33:26 INFO - 'title': 'talos-linux64-ix-045', 03:33:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:33:26 INFO - 'use_talos_json': True, 03:33:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:33:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:33:26 INFO - 'work_dir': 'build'} 03:33:26 INFO - [mozharness: 2016-09-16 10:33:26.266056Z] Running clobber step. 03:33:26 INFO - Running pre-action listener: _resource_record_pre_action 03:33:26 INFO - Running main action method: clobber 03:33:26 INFO - rmtree: /builds/slave/test/build 03:33:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:33:26 INFO - Running post-action listener: _resource_record_post_action 03:33:26 INFO - [mozharness: 2016-09-16 10:33:26.718326Z] Finished clobber step (success) 03:33:26 INFO - [mozharness: 2016-09-16 10:33:26.718427Z] Running read-buildbot-config step. 03:33:26 INFO - Running pre-action listener: _resource_record_pre_action 03:33:26 INFO - Running main action method: read_buildbot_config 03:33:26 INFO - Using buildbot properties: 03:33:26 INFO - { 03:33:26 INFO - "project": "", 03:33:26 INFO - "product": "firefox", 03:33:26 INFO - "script_repo_revision": "production", 03:33:26 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:33:26 INFO - "repository": "", 03:33:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:33:26 INFO - "buildid": "20160916004005", 03:33:26 INFO - "stage_platform": "linux64-pgo", 03:33:26 INFO - "basedir": "/builds/slave/test", 03:33:26 INFO - "nightly_build": "True", 03:33:26 INFO - "buildnumber": 521, 03:33:26 INFO - "slavename": "talos-linux64-ix-045", 03:33:26 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:33:26 INFO - "platform": "ubuntu64_hw", 03:33:26 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:33:26 INFO - "branch": "mozilla-aurora", 03:33:26 INFO - "repo_path": "releases/mozilla-aurora", 03:33:26 INFO - "revision": "2c332306c030ca66df397155349cb5dd61165f69", 03:33:26 INFO - "pgo_build": "True", 03:33:26 INFO - "builduid": "75880864348849c486b8ac5d7bccb1f5", 03:33:26 INFO - "slavebuilddir": "test" 03:33:26 INFO - } 03:33:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 03:33:26 INFO - Running post-action listener: _resource_record_post_action 03:33:26 INFO - [mozharness: 2016-09-16 10:33:26.720951Z] Finished read-buildbot-config step (success) 03:33:26 INFO - [mozharness: 2016-09-16 10:33:26.721040Z] Running download-and-extract step. 03:33:26 INFO - Running pre-action listener: _resource_record_pre_action 03:33:26 INFO - Running main action method: download_and_extract 03:33:26 INFO - mkdir: /builds/slave/test/build/tests 03:33:26 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:26 INFO - https://queue.taskcluster.net/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:33:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:33:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:33:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:33:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:33:26 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:33:26 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:33:26 INFO - retry: Failed, sleeping 30 seconds before retrying 03:33:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #2 03:33:56 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:33:56 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:33:56 INFO - retry: Failed, sleeping 60 seconds before retrying 03:34:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #3 03:34:56 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:34:56 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:34:56 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json! 03:34:56 INFO - Caught exception: HTTP Error 404: Not Found 03:34:56 INFO - Caught exception: HTTP Error 404: Not Found 03:34:56 INFO - Caught exception: HTTP Error 404: Not Found 03:34:56 INFO - trying https://queue.taskcluster.net/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:34:56 INFO - Downloading https://queue.taskcluster.net/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:34:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:34:57 INFO - Downloaded 1361 bytes. 03:34:57 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:34:57 INFO - Using the following test package requirements: 03:34:57 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:34:57 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:57 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:34:57 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:57 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:34:57 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:57 INFO - u'jsshell-linux-x86_64.zip'], 03:34:57 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:57 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:34:57 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:34:57 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:57 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:34:57 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:57 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:34:57 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:57 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:34:57 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:57 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:34:57 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:34:57 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:34:57 INFO - https://queue.taskcluster.net/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:34:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:34:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:34:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:34:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:34:57 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:34:57 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:34:57 INFO - retry: Failed, sleeping 30 seconds before retrying 03:35:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 03:35:27 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:35:27 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:35:27 INFO - retry: Failed, sleeping 60 seconds before retrying 03:36:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 03:36:27 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:36:27 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:36:27 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 03:36:27 INFO - Caught exception: HTTP Error 404: Not Found 03:36:27 INFO - Caught exception: HTTP Error 404: Not Found 03:36:27 INFO - Caught exception: HTTP Error 404: Not Found 03:36:27 INFO - trying https://queue.taskcluster.net/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:36:27 INFO - Downloading https://queue.taskcluster.net/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:36:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:36:28 INFO - Downloaded 21839995 bytes. 03:36:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:36:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:36:29 INFO - Return code: 0 03:36:29 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:36:29 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:29 INFO - https://queue.taskcluster.net/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:36:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:36:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:36:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:36:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:36:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:36:29 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:36:29 INFO - retry: Failed, sleeping 30 seconds before retrying 03:36:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 03:36:59 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:36:59 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:36:59 INFO - retry: Failed, sleeping 60 seconds before retrying 03:37:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 03:37:59 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:37:59 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:37:59 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 03:37:59 INFO - Caught exception: HTTP Error 404: Not Found 03:37:59 INFO - Caught exception: HTTP Error 404: Not Found 03:37:59 INFO - Caught exception: HTTP Error 404: Not Found 03:37:59 INFO - trying https://queue.taskcluster.net/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:37:59 INFO - Downloading https://queue.taskcluster.net/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:37:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:38:00 INFO - Downloaded 21839995 bytes. 03:38:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:38:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:38:01 INFO - Return code: 0 03:38:01 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:01 INFO - https://queue.taskcluster.net/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:38:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:38:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:38:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:38:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:38:01 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:38:01 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:38:01 INFO - retry: Failed, sleeping 30 seconds before retrying 03:38:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 03:38:31 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:38:31 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:38:31 INFO - retry: Failed, sleeping 60 seconds before retrying 03:39:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 03:39:31 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:39:31 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:39:31 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip! 03:39:31 INFO - Caught exception: HTTP Error 404: Not Found 03:39:31 INFO - Caught exception: HTTP Error 404: Not Found 03:39:31 INFO - Caught exception: HTTP Error 404: Not Found 03:39:31 INFO - trying https://queue.taskcluster.net/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:39:31 INFO - Downloading https://queue.taskcluster.net/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:39:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:39:32 INFO - Downloaded 14413740 bytes. 03:39:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:39:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:39:32 INFO - Return code: 0 03:39:32 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:32 INFO - https://queue.taskcluster.net/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:39:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:39:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:39:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:39:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:39:32 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:39:32 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:39:32 INFO - retry: Failed, sleeping 30 seconds before retrying 03:40:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #2 03:40:02 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:40:02 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:40:03 INFO - retry: Failed, sleeping 60 seconds before retrying 03:41:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #3 03:41:03 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:41:03 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:41:03 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2! 03:41:03 INFO - Caught exception: HTTP Error 404: Not Found 03:41:03 INFO - Caught exception: HTTP Error 404: Not Found 03:41:03 INFO - Caught exception: HTTP Error 404: Not Found 03:41:03 INFO - trying https://queue.taskcluster.net/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:41:03 INFO - Downloading https://queue.taskcluster.net/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:41:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:41:04 INFO - Downloaded 63868220 bytes. 03:41:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:41:04 INFO - mkdir: /builds/slave/test/properties 03:41:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:41:04 INFO - Writing to file /builds/slave/test/properties/build_url 03:41:04 INFO - Contents: 03:41:04 INFO - build_url:https://queue.taskcluster.net/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:41:04 INFO - Running post-action listener: _resource_record_post_action 03:41:04 INFO - Running post-action listener: set_extra_try_arguments 03:41:04 INFO - [mozharness: 2016-09-16 10:41:04.923753Z] Finished download-and-extract step (success) 03:41:04 INFO - [mozharness: 2016-09-16 10:41:04.923988Z] Running populate-webroot step. 03:41:04 INFO - Running pre-action listener: _resource_record_pre_action 03:41:04 INFO - Running main action method: populate_webroot 03:41:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:41:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:41:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:41:04 INFO - '--tppagecycles', 03:41:04 INFO - '7'], 03:41:04 INFO - 'tests': ['tsvgm']}}, 03:41:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:41:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:41:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:41:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:41:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:41:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:41:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:04 INFO - 'talos_options': ['--disable-e10s'], 03:41:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:41:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:41:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:04 INFO - 'talos_options': ['--disable-e10s'], 03:41:04 INFO - 'tests': ['damp', 'tps']}, 03:41:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:04 INFO - 'tests': ['damp', 'tps']}, 03:41:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:41:04 INFO - 'tests': ['dromaeo_dom']}, 03:41:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:41:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:41:04 INFO - 'tests': ['basic_compositor_video']}, 03:41:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:41:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:41:04 INFO - 'tests': ['a11yr', 03:41:04 INFO - 'ts_paint', 03:41:04 INFO - 'tpaint', 03:41:04 INFO - 'sessionrestore', 03:41:04 INFO - 'sessionrestore_no_auto_restore', 03:41:04 INFO - 'tabpaint']}, 03:41:04 INFO - 'other-e10s': {'tests': ['a11yr', 03:41:04 INFO - 'ts_paint', 03:41:04 INFO - 'tpaint', 03:41:04 INFO - 'sessionrestore', 03:41:04 INFO - 'sessionrestore_no_auto_restore', 03:41:04 INFO - 'tabpaint']}, 03:41:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:41:04 INFO - 'ts_paint', 03:41:04 INFO - 'tpaint', 03:41:04 INFO - 'sessionrestore', 03:41:04 INFO - 'sessionrestore_no_auto_restore', 03:41:04 INFO - 'tabpaint']}, 03:41:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:41:04 INFO - 'ts_paint', 03:41:04 INFO - 'tpaint', 03:41:04 INFO - 'sessionrestore', 03:41:04 INFO - 'sessionrestore_no_auto_restore', 03:41:04 INFO - 'tabpaint']}, 03:41:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:41:04 INFO - 'tests': ['a11yr', 03:41:04 INFO - 'ts_paint', 03:41:04 INFO - 'tpaint', 03:41:04 INFO - 'sessionrestore', 03:41:04 INFO - 'sessionrestore_no_auto_restore', 03:41:04 INFO - 'tabpaint']}, 03:41:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:41:04 INFO - 'tests': ['a11yr', 03:41:04 INFO - 'ts_paint', 03:41:04 INFO - 'tpaint', 03:41:04 INFO - 'sessionrestore', 03:41:04 INFO - 'sessionrestore_no_auto_restore', 03:41:04 INFO - 'tabpaint']}, 03:41:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:41:04 INFO - 'tests': ['tsvgx', 03:41:04 INFO - 'tsvgr_opacity', 03:41:04 INFO - 'tart', 03:41:04 INFO - 'tscrollx', 03:41:04 INFO - 'cart']}, 03:41:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:41:04 INFO - 'tsvgr_opacity', 03:41:04 INFO - 'tart', 03:41:04 INFO - 'tscrollx', 03:41:04 INFO - 'cart']}, 03:41:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:04 INFO - 'talos_options': ['--disable-e10s'], 03:41:04 INFO - 'tests': ['tp5o']}, 03:41:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:04 INFO - 'tests': ['tp5o']}, 03:41:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:04 INFO - 'talos_options': ['--disable-e10s', 03:41:04 INFO - '--xperf_path', 03:41:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:41:04 INFO - 'tests': ['tp5n']}, 03:41:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:04 INFO - 'talos_options': ['--xperf_path', 03:41:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:41:04 INFO - 'tests': ['tp5n']}}, 03:41:04 INFO - 'talos.zip': {'path': '', 03:41:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:41:04 INFO - Running post-action listener: _resource_record_post_action 03:41:04 INFO - [mozharness: 2016-09-16 10:41:04.940270Z] Finished populate-webroot step (success) 03:41:04 INFO - [mozharness: 2016-09-16 10:41:04.940359Z] Running create-virtualenv step. 03:41:04 INFO - Running pre-action listener: _resource_record_pre_action 03:41:04 INFO - Running main action method: create_virtualenv 03:41:04 INFO - Creating virtualenv /builds/slave/test/build/venv 03:41:04 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 03:41:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:41:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:41:05 INFO - Using real prefix '/usr' 03:41:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:41:05 INFO - Installing distribute.............................................................................................................................................................................................done. 03:41:07 INFO - Installing pip.................done. 03:41:07 INFO - Return code: 0 03:41:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:41:07 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:07 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:07 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 0x172b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ec180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ea3b0>, '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 0x19eb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19eb740>, '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': '4300f881736b422476174874000001bc-1474022003.178916-1333656674', '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 03:41:07 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 03:41:07 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 03:41:07 INFO - Using env: {'DISPLAY': ':0', 03:41:07 INFO - 'HOME': '/home/cltbld', 03:41:07 INFO - 'LANG': 'en_US.UTF-8', 03:41:07 INFO - 'LANGUAGE': 'en_US:en', 03:41:07 INFO - 'LOGNAME': 'cltbld', 03:41:07 INFO - 'MAIL': '/var/mail/cltbld', 03:41:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:07 INFO - 'MOZ_NO_REMOTE': '1', 03:41:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:07 INFO - 'NO_EM_RESTART': '1', 03:41:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:07 INFO - 'PWD': '/builds/slave/test', 03:41:07 INFO - 'SHELL': '/bin/bash', 03:41:07 INFO - 'SHLVL': '1', 03:41:07 INFO - 'TERM': 'linux', 03:41:07 INFO - 'TMOUT': '86400', 03:41:07 INFO - 'USER': 'cltbld', 03:41:07 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1474022003.178916-1333656674', 03:41:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:07 INFO - '_': '/tools/buildbot/bin/python'} 03:41:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:07 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 03:41:07 INFO - Cleaning up... 03:41:07 INFO - Return code: 0 03:41:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:41:07 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:07 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:07 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 0x172b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ec180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ea3b0>, '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 0x19eb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19eb740>, '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': '4300f881736b422476174874000001bc-1474022003.178916-1333656674', '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 03:41:07 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 03:41:07 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 03:41:07 INFO - Using env: {'DISPLAY': ':0', 03:41:07 INFO - 'HOME': '/home/cltbld', 03:41:07 INFO - 'LANG': 'en_US.UTF-8', 03:41:07 INFO - 'LANGUAGE': 'en_US:en', 03:41:07 INFO - 'LOGNAME': 'cltbld', 03:41:07 INFO - 'MAIL': '/var/mail/cltbld', 03:41:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:07 INFO - 'MOZ_NO_REMOTE': '1', 03:41:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:07 INFO - 'NO_EM_RESTART': '1', 03:41:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:07 INFO - 'PWD': '/builds/slave/test', 03:41:07 INFO - 'SHELL': '/bin/bash', 03:41:07 INFO - 'SHLVL': '1', 03:41:07 INFO - 'TERM': 'linux', 03:41:07 INFO - 'TMOUT': '86400', 03:41:07 INFO - 'USER': 'cltbld', 03:41:07 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1474022003.178916-1333656674', 03:41:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:07 INFO - '_': '/tools/buildbot/bin/python'} 03:41:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:07 INFO - Downloading/unpacking psutil>=3.1.1 03:41:07 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 03:41:07 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 03:41:07 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 03:41:07 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 03:41:07 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 03:41:07 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 03:41:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:41:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:41:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:41:09 INFO - Installing collected packages: psutil 03:41:09 INFO - Running setup.py install for psutil 03:41:10 INFO - building 'psutil._psutil_linux' extension 03:41:10 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 03:41:10 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 03:41:10 INFO - building 'psutil._psutil_posix' extension 03:41:10 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 03:41:10 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 03:41:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:41:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:41:10 INFO - Successfully installed psutil 03:41:10 INFO - Cleaning up... 03:41:10 INFO - Return code: 0 03:41:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:41:10 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:10 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:10 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 0x172b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ec180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ea3b0>, '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 0x19eb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19eb740>, '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': '4300f881736b422476174874000001bc-1474022003.178916-1333656674', '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 03:41:10 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 03:41:10 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 03:41:10 INFO - Using env: {'DISPLAY': ':0', 03:41:10 INFO - 'HOME': '/home/cltbld', 03:41:10 INFO - 'LANG': 'en_US.UTF-8', 03:41:10 INFO - 'LANGUAGE': 'en_US:en', 03:41:10 INFO - 'LOGNAME': 'cltbld', 03:41:10 INFO - 'MAIL': '/var/mail/cltbld', 03:41:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:10 INFO - 'MOZ_NO_REMOTE': '1', 03:41:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:10 INFO - 'NO_EM_RESTART': '1', 03:41:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:10 INFO - 'PWD': '/builds/slave/test', 03:41:10 INFO - 'SHELL': '/bin/bash', 03:41:10 INFO - 'SHLVL': '1', 03:41:10 INFO - 'TERM': 'linux', 03:41:10 INFO - 'TMOUT': '86400', 03:41:10 INFO - 'USER': 'cltbld', 03:41:10 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1474022003.178916-1333656674', 03:41:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:10 INFO - '_': '/tools/buildbot/bin/python'} 03:41:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:41:10 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 03:41:10 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 03:41:10 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 03:41:10 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 03:41:10 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 03:41:10 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 03:41:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:41:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:41:12 INFO - Installing collected packages: mozsystemmonitor 03:41:12 INFO - Running setup.py install for mozsystemmonitor 03:41:12 INFO - Successfully installed mozsystemmonitor 03:41:12 INFO - Cleaning up... 03:41:12 INFO - Return code: 0 03:41:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:41:12 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:12 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:12 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 0x172b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ec180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ea3b0>, '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 0x19eb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19eb740>, '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': '4300f881736b422476174874000001bc-1474022003.178916-1333656674', '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 03:41:12 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 03:41:12 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 03:41:12 INFO - Using env: {'DISPLAY': ':0', 03:41:12 INFO - 'HOME': '/home/cltbld', 03:41:12 INFO - 'LANG': 'en_US.UTF-8', 03:41:12 INFO - 'LANGUAGE': 'en_US:en', 03:41:12 INFO - 'LOGNAME': 'cltbld', 03:41:12 INFO - 'MAIL': '/var/mail/cltbld', 03:41:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:12 INFO - 'MOZ_NO_REMOTE': '1', 03:41:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:12 INFO - 'NO_EM_RESTART': '1', 03:41:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:12 INFO - 'PWD': '/builds/slave/test', 03:41:12 INFO - 'SHELL': '/bin/bash', 03:41:12 INFO - 'SHLVL': '1', 03:41:12 INFO - 'TERM': 'linux', 03:41:12 INFO - 'TMOUT': '86400', 03:41:12 INFO - 'USER': 'cltbld', 03:41:12 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1474022003.178916-1333656674', 03:41:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:12 INFO - '_': '/tools/buildbot/bin/python'} 03:41:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:13 INFO - Downloading/unpacking jsonschema==2.5.1 03:41:13 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 03:41:13 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 03:41:13 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 03:41:13 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 03:41:13 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 03:41:13 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 03:41:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:41:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:41:14 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 03:41:14 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 03:41:14 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 03:41:14 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 03:41:14 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 03:41:14 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 03:41:15 INFO - Downloading functools32-3.2.3-2.tar.gz 03:41:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:41:15 INFO - warning: no files found matching '*.txt' 03:41:15 INFO - no previously-included directories found matching 'build' 03:41:15 INFO - no previously-included directories found matching 'dist' 03:41:15 INFO - no previously-included directories found matching '.git*' 03:41:15 INFO - Installing collected packages: jsonschema, functools32 03:41:15 INFO - Running setup.py install for functools32 03:41:15 INFO - warning: no files found matching '*.txt' 03:41:15 INFO - no previously-included directories found matching 'build' 03:41:15 INFO - no previously-included directories found matching 'dist' 03:41:15 INFO - no previously-included directories found matching '.git*' 03:41:15 INFO - Successfully installed jsonschema functools32 03:41:15 INFO - Cleaning up... 03:41:15 INFO - Return code: 0 03:41:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:41:15 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:15 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:15 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 0x172b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ec180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ea3b0>, '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 0x19eb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19eb740>, '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': '4300f881736b422476174874000001bc-1474022003.178916-1333656674', '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 03:41:15 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 03:41:15 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 03:41:15 INFO - Using env: {'DISPLAY': ':0', 03:41:15 INFO - 'HOME': '/home/cltbld', 03:41:15 INFO - 'LANG': 'en_US.UTF-8', 03:41:15 INFO - 'LANGUAGE': 'en_US:en', 03:41:15 INFO - 'LOGNAME': 'cltbld', 03:41:15 INFO - 'MAIL': '/var/mail/cltbld', 03:41:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:15 INFO - 'MOZ_NO_REMOTE': '1', 03:41:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:15 INFO - 'NO_EM_RESTART': '1', 03:41:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:15 INFO - 'PWD': '/builds/slave/test', 03:41:15 INFO - 'SHELL': '/bin/bash', 03:41:15 INFO - 'SHLVL': '1', 03:41:15 INFO - 'TERM': 'linux', 03:41:15 INFO - 'TMOUT': '86400', 03:41:15 INFO - 'USER': 'cltbld', 03:41:15 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1474022003.178916-1333656674', 03:41:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:15 INFO - '_': '/tools/buildbot/bin/python'} 03:41:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:41:15 INFO - Cleaning up... 03:41:15 INFO - Return code: 0 03:41:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:41:15 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:15 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:15 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 0x172b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ec180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ea3b0>, '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 0x19eb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19eb740>, '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': '4300f881736b422476174874000001bc-1474022003.178916-1333656674', '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 03:41:15 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 03:41:15 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 03:41:15 INFO - Using env: {'DISPLAY': ':0', 03:41:15 INFO - 'HOME': '/home/cltbld', 03:41:15 INFO - 'LANG': 'en_US.UTF-8', 03:41:15 INFO - 'LANGUAGE': 'en_US:en', 03:41:15 INFO - 'LOGNAME': 'cltbld', 03:41:15 INFO - 'MAIL': '/var/mail/cltbld', 03:41:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:15 INFO - 'MOZ_NO_REMOTE': '1', 03:41:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:15 INFO - 'NO_EM_RESTART': '1', 03:41:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:15 INFO - 'PWD': '/builds/slave/test', 03:41:15 INFO - 'SHELL': '/bin/bash', 03:41:15 INFO - 'SHLVL': '1', 03:41:15 INFO - 'TERM': 'linux', 03:41:15 INFO - 'TMOUT': '86400', 03:41:15 INFO - 'USER': 'cltbld', 03:41:15 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1474022003.178916-1333656674', 03:41:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:15 INFO - '_': '/tools/buildbot/bin/python'} 03:41:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:15 INFO - Downloading/unpacking blobuploader==1.2.4 03:41:15 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 03:41:15 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 03:41:15 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 03:41:15 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 03:41:15 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 03:41:15 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 03:41:17 INFO - Downloading blobuploader-1.2.4.tar.gz 03:41:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:41:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:41:17 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 03:41:17 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 03:41:17 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 03:41:17 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 03:41:17 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 03:41:17 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 03:41:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:41:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:41:18 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 03:41:18 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 03:41:18 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 03:41:18 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 03:41:18 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 03:41:18 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 03:41:18 INFO - Downloading docopt-0.6.1.tar.gz 03:41:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:41:18 INFO - Installing collected packages: blobuploader, requests, docopt 03:41:18 INFO - Running setup.py install for blobuploader 03:41:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:41:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:41:18 INFO - Running setup.py install for requests 03:41:19 INFO - Running setup.py install for docopt 03:41:19 INFO - Successfully installed blobuploader requests docopt 03:41:19 INFO - Cleaning up... 03:41:19 INFO - Return code: 0 03:41:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:41: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:19 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 0x172b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ec180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ea3b0>, '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 0x19eb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19eb740>, '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': '4300f881736b422476174874000001bc-1474022003.178916-1333656674', '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 03:41:19 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 03:41:19 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 03:41:19 INFO - Using env: {'DISPLAY': ':0', 03:41:19 INFO - 'HOME': '/home/cltbld', 03:41:19 INFO - 'LANG': 'en_US.UTF-8', 03:41:19 INFO - 'LANGUAGE': 'en_US:en', 03:41:19 INFO - 'LOGNAME': 'cltbld', 03:41:19 INFO - 'MAIL': '/var/mail/cltbld', 03:41:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:19 INFO - 'MOZ_NO_REMOTE': '1', 03:41:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:19 INFO - 'NO_EM_RESTART': '1', 03:41:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:19 INFO - 'PWD': '/builds/slave/test', 03:41:19 INFO - 'SHELL': '/bin/bash', 03:41:19 INFO - 'SHLVL': '1', 03:41:19 INFO - 'TERM': 'linux', 03:41:19 INFO - 'TMOUT': '86400', 03:41:19 INFO - 'USER': 'cltbld', 03:41:19 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1474022003.178916-1333656674', 03:41:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:19 INFO - '_': '/tools/buildbot/bin/python'} 03:41:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:41:19 INFO - Running setup.py (path:/tmp/pip-xsBMhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:41:19 INFO - Running setup.py (path:/tmp/pip-X2lYZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:41:19 INFO - Running setup.py (path:/tmp/pip-fDQVIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:41:19 INFO - Running setup.py (path:/tmp/pip-cVMJnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:41:19 INFO - Running setup.py (path:/tmp/pip-oFK_LJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:41:19 INFO - Running setup.py (path:/tmp/pip-W4cxHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:41:19 INFO - Running setup.py (path:/tmp/pip-6tHjoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:41:19 INFO - Running setup.py (path:/tmp/pip-0edqJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:41:19 INFO - Running setup.py (path:/tmp/pip-9LYizw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:41:20 INFO - Running setup.py (path:/tmp/pip-MRYk7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:41:20 INFO - Running setup.py (path:/tmp/pip-EZsdpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:41:20 INFO - Running setup.py (path:/tmp/pip-VN0tDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:41:20 INFO - Running setup.py (path:/tmp/pip-Ztvjft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:41:20 INFO - Running setup.py (path:/tmp/pip-dkk3j2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:20 INFO - Running setup.py (path:/tmp/pip-Trlv6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:41:20 INFO - Running setup.py (path:/tmp/pip-vezjdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:41:20 INFO - Running setup.py (path:/tmp/pip-DBWqHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:41:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:41:20 INFO - Running setup.py install for manifestparser 03:41:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:41:20 INFO - Running setup.py install for mozcrash 03:41:20 INFO - Running setup.py install for mozdebug 03:41:20 INFO - Running setup.py install for mozdevice 03:41:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:41:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:41:21 INFO - Running setup.py install for mozfile 03:41:21 INFO - Running setup.py install for mozhttpd 03:41:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:41:21 INFO - Running setup.py install for mozinfo 03:41:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:41:21 INFO - Running setup.py install for mozInstall 03:41:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:41:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:41:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:41:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:41:21 INFO - Running setup.py install for mozleak 03:41:21 INFO - Running setup.py install for mozlog 03:41:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:41:21 INFO - Running setup.py install for moznetwork 03:41:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:41:21 INFO - Running setup.py install for mozprocess 03:41:21 INFO - Running setup.py install for mozprofile 03:41:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:41:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:41:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:41:21 INFO - Running setup.py install for mozrunner 03:41:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:41:22 INFO - Running setup.py install for mozscreenshot 03:41:22 INFO - Running setup.py install for moztest 03:41:22 INFO - Running setup.py install for mozversion 03:41:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:41:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:41:22 INFO - Cleaning up... 03:41:22 INFO - Return code: 0 03:41:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:41: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:22 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 0x172b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ec180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ea3b0>, '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 0x19eb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19eb740>, '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': '4300f881736b422476174874000001bc-1474022003.178916-1333656674', '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 03:41:22 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 03:41:22 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 03:41:22 INFO - Using env: {'DISPLAY': ':0', 03:41:22 INFO - 'HOME': '/home/cltbld', 03:41:22 INFO - 'LANG': 'en_US.UTF-8', 03:41:22 INFO - 'LANGUAGE': 'en_US:en', 03:41:22 INFO - 'LOGNAME': 'cltbld', 03:41:22 INFO - 'MAIL': '/var/mail/cltbld', 03:41:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:22 INFO - 'MOZ_NO_REMOTE': '1', 03:41:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:22 INFO - 'NO_EM_RESTART': '1', 03:41:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:22 INFO - 'PWD': '/builds/slave/test', 03:41:22 INFO - 'SHELL': '/bin/bash', 03:41:22 INFO - 'SHLVL': '1', 03:41:22 INFO - 'TERM': 'linux', 03:41:22 INFO - 'TMOUT': '86400', 03:41:22 INFO - 'USER': 'cltbld', 03:41:22 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1474022003.178916-1333656674', 03:41:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:22 INFO - '_': '/tools/buildbot/bin/python'} 03:41:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:41:22 INFO - Running setup.py (path:/tmp/pip-VBCV1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:41:22 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)) 03:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:41:22 INFO - Running setup.py (path:/tmp/pip-Z6JU2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 03:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:41:22 INFO - Running setup.py (path:/tmp/pip-3lgm3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:41:22 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)) 03:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:41:22 INFO - Running setup.py (path:/tmp/pip-7n3OK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 03:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:41:22 INFO - Running setup.py (path:/tmp/pip-ZHpxZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:41:23 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)) 03:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:41:23 INFO - Running setup.py (path:/tmp/pip-w5vNfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:41:23 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)) 03:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:41:23 INFO - Running setup.py (path:/tmp/pip-OMDwHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:41:23 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)) 03:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:41:23 INFO - Running setup.py (path:/tmp/pip-FHeNio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:41:23 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)) 03:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:41:23 INFO - Running setup.py (path:/tmp/pip-LCLXSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:41:23 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)) 03:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:41:23 INFO - Running setup.py (path:/tmp/pip-GsNrI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:41:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 03:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:41:23 INFO - Running setup.py (path:/tmp/pip-WH3x6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:41:23 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)) 03:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:41:23 INFO - Running setup.py (path:/tmp/pip-Ne84jy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:41:23 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)) 03:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:41:23 INFO - Running setup.py (path:/tmp/pip-zS4AXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:41:23 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)) 03:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:41:23 INFO - Running setup.py (path:/tmp/pip-0Dq76q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:41:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 03:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:23 INFO - Running setup.py (path:/tmp/pip-eY8Joi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:23 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)) 03:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:41:23 INFO - Running setup.py (path:/tmp/pip-E23lKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:41:23 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)) 03:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:41:23 INFO - Running setup.py (path:/tmp/pip-FgthtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:41:23 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)) 03:41:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:41:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:41:23 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)) 03:41:23 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:41:23 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:41:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:41:23 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 03:41:23 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 03:41:23 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 03:41:23 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 03:41:23 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 03:41:23 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 03:41:25 INFO - Downloading blessings-1.6.tar.gz 03:41:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:41:25 INFO - Installing collected packages: blessings 03:41:25 INFO - Running setup.py install for blessings 03:41:26 INFO - Successfully installed blessings 03:41:26 INFO - Cleaning up... 03:41:26 INFO - Return code: 0 03:41:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:41:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:41:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:41:26 INFO - Reading from file tmpfile_stdout 03:41:26 INFO - Current package versions: 03:41:26 INFO - argparse == 1.2.1 03:41:26 INFO - blessings == 1.6 03:41:26 INFO - blobuploader == 1.2.4 03:41:26 INFO - docopt == 0.6.1 03:41:26 INFO - functools32 == 3.2.3-2 03:41:26 INFO - jsonschema == 2.5.1 03:41:26 INFO - manifestparser == 1.1 03:41:26 INFO - mozInstall == 1.12 03:41:26 INFO - mozcrash == 0.17 03:41:26 INFO - mozdebug == 0.1 03:41:26 INFO - mozdevice == 0.48 03:41:26 INFO - mozfile == 1.2 03:41:26 INFO - mozhttpd == 0.7 03:41:26 INFO - mozinfo == 0.9 03:41:26 INFO - mozleak == 0.1 03:41:26 INFO - mozlog == 3.3 03:41:26 INFO - moznetwork == 0.27 03:41:26 INFO - mozprocess == 0.23 03:41:26 INFO - mozprofile == 0.28 03:41:26 INFO - mozrunner == 6.12 03:41:26 INFO - mozscreenshot == 0.1 03:41:26 INFO - mozsystemmonitor == 0.3 03:41:26 INFO - moztest == 0.7 03:41:26 INFO - mozversion == 1.4 03:41:26 INFO - psutil == 3.1.1 03:41:26 INFO - requests == 1.2.3 03:41:26 INFO - wsgiref == 0.1.2 03:41:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:41:26 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:26 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:26 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 0x172b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ec180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ea3b0>, '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 0x19eb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19eb740>, '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': '4300f881736b422476174874000001bc-1474022003.178916-1333656674', '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 03:41:26 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 03:41:26 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 03:41:26 INFO - Using env: {'DISPLAY': ':0', 03:41:26 INFO - 'HOME': '/home/cltbld', 03:41:26 INFO - 'LANG': 'en_US.UTF-8', 03:41:26 INFO - 'LANGUAGE': 'en_US:en', 03:41:26 INFO - 'LOGNAME': 'cltbld', 03:41:26 INFO - 'MAIL': '/var/mail/cltbld', 03:41:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:26 INFO - 'MOZ_NO_REMOTE': '1', 03:41:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:26 INFO - 'NO_EM_RESTART': '1', 03:41:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:26 INFO - 'PWD': '/builds/slave/test', 03:41:26 INFO - 'SHELL': '/bin/bash', 03:41:26 INFO - 'SHLVL': '1', 03:41:26 INFO - 'TERM': 'linux', 03:41:26 INFO - 'TMOUT': '86400', 03:41:26 INFO - 'USER': 'cltbld', 03:41:26 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1474022003.178916-1333656674', 03:41:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:26 INFO - '_': '/tools/buildbot/bin/python'} 03:41:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:26 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)) 03:41:26 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)) 03:41:26 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)) 03:41:26 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)) 03:41:26 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)) 03:41:26 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)) 03:41:26 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)) 03:41:26 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)) 03:41:26 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)) 03:41:26 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)) 03:41:26 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)) 03:41:26 INFO - Cleaning up... 03:41:26 INFO - Return code: 0 03:41:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:41:26 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:26 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:26 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 0x172b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ec180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ea3b0>, '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 0x19eb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19eb740>, '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': '4300f881736b422476174874000001bc-1474022003.178916-1333656674', '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 03:41:26 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 03:41:26 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 03:41:26 INFO - Using env: {'DISPLAY': ':0', 03:41:26 INFO - 'HOME': '/home/cltbld', 03:41:26 INFO - 'LANG': 'en_US.UTF-8', 03:41:26 INFO - 'LANGUAGE': 'en_US:en', 03:41:26 INFO - 'LOGNAME': 'cltbld', 03:41:26 INFO - 'MAIL': '/var/mail/cltbld', 03:41:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:26 INFO - 'MOZ_NO_REMOTE': '1', 03:41:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:26 INFO - 'NO_EM_RESTART': '1', 03:41:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:26 INFO - 'PWD': '/builds/slave/test', 03:41:26 INFO - 'SHELL': '/bin/bash', 03:41:26 INFO - 'SHLVL': '1', 03:41:26 INFO - 'TERM': 'linux', 03:41:26 INFO - 'TMOUT': '86400', 03:41:26 INFO - 'USER': 'cltbld', 03:41:26 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1474022003.178916-1333656674', 03:41:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:26 INFO - '_': '/tools/buildbot/bin/python'} 03:41:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:41:26 INFO - Cleaning up... 03:41:26 INFO - Return code: 0 03:41:26 INFO - Running post-action listener: _resource_record_post_action 03:41:26 INFO - Running post-action listener: _start_resource_monitoring 03:41:26 INFO - Starting resource monitoring. 03:41:26 INFO - [mozharness: 2016-09-16 10:41:26.796346Z] Finished create-virtualenv step (success) 03:41:26 INFO - [mozharness: 2016-09-16 10:41:26.796851Z] Running install step. 03:41:26 INFO - Running pre-action listener: _resource_record_pre_action 03:41:26 INFO - Running main action method: install 03:41:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:41:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:41:27 INFO - Reading from file tmpfile_stdout 03:41:27 INFO - Detecting whether we're running mozinstall >=1.0... 03:41:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:41:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:41:27 INFO - Reading from file tmpfile_stdout 03:41:27 INFO - Output received: 03:41:27 INFO - Usage: mozinstall [options] installer 03:41:27 INFO - Options: 03:41:27 INFO - -h, --help show this help message and exit 03:41:27 INFO - -d DEST, --destination=DEST 03:41:27 INFO - Directory to install application into. [default: 03:41:27 INFO - "/builds/slave/test"] 03:41:27 INFO - --app=APP Application being installed. [default: firefox] 03:41:27 INFO - mkdir: /builds/slave/test/build/application 03:41:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:41:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:41:43 INFO - Reading from file tmpfile_stdout 03:41:43 INFO - Output received: 03:41:43 INFO - /builds/slave/test/build/application/firefox/firefox 03:41:43 INFO - Running post-action listener: _resource_record_post_action 03:41:43 INFO - [mozharness: 2016-09-16 10:41:43.119932Z] Finished install step (success) 03:41:43 INFO - [mozharness: 2016-09-16 10:41:43.120080Z] Running run-tests step. 03:41:43 INFO - Running pre-action listener: _resource_record_pre_action 03:41:43 INFO - Running main action method: run_tests 03:41:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:41:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:41:43 INFO - Python 2.7.3 03:41:43 INFO - Return code: 0 03:41:43 INFO - grabbing minidump binary from tooltool 03:41:43 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:43 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 0x19ea3b0>, '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 0x19eb2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19eb740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:41:43 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 03:41:43 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 03:41:43 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 03:41:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:41:43 INFO - Return code: 0 03:41:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:41:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:41:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:41:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:41:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:41:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 03:41:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 03:41:43 INFO - Using env: {'DISPLAY': ':0', 03:41:43 INFO - 'HOME': '/home/cltbld', 03:41:43 INFO - 'LANG': 'en_US.UTF-8', 03:41:43 INFO - 'LANGUAGE': 'en_US:en', 03:41:43 INFO - 'LOGNAME': 'cltbld', 03:41:43 INFO - 'MAIL': '/var/mail/cltbld', 03:41:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:41:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:41:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:43 INFO - 'MOZ_NO_REMOTE': '1', 03:41:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:41:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:43 INFO - 'NO_EM_RESTART': '1', 03:41:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:43 INFO - 'PWD': '/builds/slave/test', 03:41:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:41:43 INFO - 'SHELL': '/bin/bash', 03:41:43 INFO - 'SHLVL': '1', 03:41:43 INFO - 'TERM': 'linux', 03:41:43 INFO - 'TMOUT': '86400', 03:41:43 INFO - 'USER': 'cltbld', 03:41:43 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1474022003.178916-1333656674', 03:41:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:43 INFO - '_': '/tools/buildbot/bin/python'} 03:41:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 03:41:43 INFO - mozversion application_buildid: 20160916004005 03:41:43 INFO - mozversion application_changeset: 2c332306c030ca66df397155349cb5dd61165f69 03:41:43 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:41:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:41:43 INFO - mozversion application_name: Firefox 03:41:43 INFO - mozversion application_remotingname: firefox-dev 03:41:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:41:43 INFO - mozversion application_vendor: Mozilla 03:41:43 INFO - mozversion application_version: 50.0a2 03:41:43 INFO - mozversion platform_buildid: 20160916004005 03:41:43 INFO - mozversion platform_changeset: 2c332306c030ca66df397155349cb5dd61165f69 03:41:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:41:43 INFO - mozversion platform_version: 50.0a2 03:41:43 INFO - using testdate: 1474022503 03:41:43 INFO - actual date: 1474022503 03:41:43 INFO - starting webserver on 'localhost:40157' 03:41:43 INFO - SUITE-START | Running 2 tests 03:41:43 INFO - TEST-START | dromaeo_css 03:41:43 INFO - operating with platform_type : linux_ 03:41:43 INFO - Initialising browser for dromaeo_css test... 03:41:43 INFO - TEST-INFO | started process 12759 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjOvWTh/profile http://localhost:40157/getInfo.html) 03:41:47 INFO - PROCESS | 12759 | __metrics Screen width/height:1600/1200 03:41:47 INFO - PROCESS | 12759 | colorDepth:24 03:41:47 INFO - PROCESS | 12759 | Browser inner width/height: 1024/697 03:41:47 INFO - PROCESS | 12759 | __metrics 03:41:48 INFO - PROCESS | 12759 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:41:48 INFO - PROCESS | 12759 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:41:49 INFO - TEST-INFO | 12759: exit 0 03:41:49 INFO - Browser initialized. 03:41:49 INFO - Running cycle 1/1 for dromaeo_css test... 03:41:49 INFO - TEST-INFO | started process 12847 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjOvWTh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:42:01 INFO - PROCESS | 12847 | RSS: Main: 145633280 03:42:01 INFO - PROCESS | 12847 | 03:42:52 INFO - PROCESS | 12847 | 1474022572007 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] 03:45:00 INFO - PROCESS | 12847 | Cycle 1(1): loaded http://localhost:40157/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40157/tests/dromaeo/cssquery-ext.html) 03:45:02 INFO - PROCESS | 12847 | RSS: Main: 274509824 03:45:02 INFO - PROCESS | 12847 | 03:48:04 INFO - PROCESS | 12847 | Cycle 1(1): loaded http://localhost:40157/tests/dromaeo/cssquery-ext.html (next: http://localhost:40157/tests/dromaeo/cssquery-jquery.html) 03:48:04 INFO - PROCESS | 12847 | RSS: Main: 228683776 03:48:04 INFO - PROCESS | 12847 | 03:51:06 INFO - PROCESS | 12847 | Cycle 1(1): loaded http://localhost:40157/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40157/tests/dromaeo/cssquery-mootools.html) 03:51:07 INFO - PROCESS | 12847 | RSS: Main: 176193536 03:51:07 INFO - PROCESS | 12847 | 03:54:09 INFO - PROCESS | 12847 | Cycle 1(1): loaded http://localhost:40157/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40157/tests/dromaeo/cssquery-prototype.html) 03:54:09 INFO - PROCESS | 12847 | RSS: Main: 176029696 03:54:09 INFO - PROCESS | 12847 | 03:57:12 INFO - PROCESS | 12847 | Cycle 1(1): loaded http://localhost:40157/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40157/tests/dromaeo/cssquery-yui.html) 03:57:13 INFO - PROCESS | 12847 | RSS: Main: 177963008 03:57:13 INFO - PROCESS | 12847 | 04:00:15 INFO - PROCESS | 12847 | Cycle 1(1): loaded http://localhost:40157/tests/dromaeo/cssquery-yui.html (next: http://localhost:40157/tests/dromaeo/cssquery-dojo.html) 04:00:15 INFO - PROCESS | 12847 | RSS: Main: 265895936 04:00:15 INFO - PROCESS | 12847 | 04:00:15 INFO - PROCESS | 12847 | __start_tp_report 04:00:15 INFO - PROCESS | 12847 | _x_x_mozilla_page_load 04:00:15 INFO - PROCESS | 12847 | _x_x_mozilla_page_load_details 04:00:15 INFO - PROCESS | 12847 | |i|pagename|runs| 04:00:15 INFO - PROCESS | 12847 | |0;dojo.html;3233.983830080849;3236.2233064064626;3263.6409994900555;3287.7534184936135;3303.4879593662977;5520.751566179521;5541.63979341343;5599.104143337072;5604.831855044345;5619.690916999563;5571.052921003429;5619.662820230778;5629.774809007645;5646.548276137909;5677.091665333547;5009.12340340439;5070.391553013644;5102.132637451624;5174.793008279665;5188.662736922107;4972.378452693413;5085.949140508585;5115.053715062725;5134.435212126663;5154.561862241695;5043.84868453947;5066.797328106872;5082.872928176806;5086.796528138889;5134.4095429025765;5152.381714194302;5193.298904647862;5197.558207552324;5202.947970520322;5229.555487783543;4896.608271338285;4932.136876046713;4948.406191257036;5080.847574572768;5083.79664813407;5507.669539827583;5514.889702205934;5536.031194540939;5538.030844602178;5541.639793413456;6043.969780151115;6049.727762250709;6050.062240352752;6052.152698622196;6058.787942422038;5948.643081415129;5987.850303742398;6009.729562169713;6041.486473649745;6065.4844338231305;5618.410066942994;5622.971885140548;5634.126710359901;5641.605087643908;5668.43315668434;5937.584369094122;6190.41191086846;6194.876102477925;6201.410865967726;6207.503399728102;5825.271841019872;5852.414758524199;5869.325027621793;5940.524758019348;5951.970240148771;5995.100734889801;5995.970020149872;6005.069214271794;6009.789657361971;6028.4272994065495;5738.454846789548;5970.373110823388;5991.640501569833;6002.129691194839;6002.369751176151;5807.157962095473;5840.912386314209;5844.795432159939;5898.705064746746;5936.8812623748145;4517.593416592523;4532;4535.138323718483;4537.6143027842345;4562.8631141065825;4027.2146931348107;4088.0188754698656;4096.446979657768;4097.672186225095;4137.668986481074;5477.315335583052;5593.664380137205;5606.803761868397;5715.828525144252;5731.0543760279925;5881.588548695015;5919.200907877382;5941.762329506858;5959.314678811992;5965.761369545169;5653.208550802891;5665.5467562594895;5667.546596272288;5683.0338842396895;5685.090385538294;4957.3307603473795;5019.422766381913;5030.698158110452;5036;5106.923396148986;6052.303985041688;6053.636781793019;6054.757809687563;6066.454019138387;6067.848303792352;5833.883322333614;5841.532677385714;5843.386444423274;5851.795187168429;5857.121431785266;6014.0377539593455;6116.822755456359;6136.856084434072;6142.201513803177;6230.221222347207;5900.232969713909;5912.349641539513;5919.082542205965;5920.437558431942;5921.822345329647;5964.373740757158;6001.789937352171;6010.939890601038;6020.217371741645;6024.728887199999;5649.943500564942;5671.801486947937;5672.404397538364;5725.484706376279;5906.527477801851;5700.686462244616;5710.857228569319;5712.6286791358425;5722.284714410699;5741.885162296647;5609.102543593006;5658.434156584309;5658.490735833795;5669.489745922887;5669.631473954345;5682.6306290091015;5718.628289161191;5736.368999410145;5807.216025836458;5826.155207494974;5697.430256974435;5702.800401985911;5708.80019199326;5727.11229759388;5729.054705973468 04:00:15 INFO - PROCESS | 12847 | |1;ext.html;585.4467528185863;629.8834715577618;638.7253481003169;640.0015975078875;666.1839246922519;46514.76742616286;48636.75681621587;48726.51273487264;48745.51254487454;52842;49878.50121498784;50337;50369.74815125919;50386;50386.74033149173;8948.463092214455;9421.5396613525;9518.428894266332;9577.473238971854;9579.473128977903;11152.832707509393;11491.253068550559;11499;11866.821997670042;11871;11632.941835290812;11673.474693638807;11691.298522088659;11699.23954942926;11708.180427370087;11427;11464.885351146466;11465.31208127515;11476.254043487146;11482.942585287105;11233.831492527537;11276.887231127666;11324.094072474183;11341.092712582973;11341.319520828776;46710.532894670956;47038.52961470376;47065.76467117677;47114.87983040771;47138.5286147141;3818.751781134245;3857.286402015608;3871.457995880579;4009.939850902239;4164.250434921712;35314.58741650331;35460.46809297863;35512.112197195274;35557;35716.82141589275;4785.760711964388;4855.417349917997;4904.828331008433;4911.950880491185;4963.726995015273;386576;389330;389482;390740;392592.03703981586;66046;66710.99933501001;66765.33234667688;66765.66617166882;66864;39987.80006099951;41350.79324603358;41363.37954930678;43248;43316;17257;17426.39007634752;17459.301627934994;17498.650026999643;17515.299388024338;10515.263931524873;12137.332446715338;12219.327936963375;12797.360131993362;13134.474621015244;21075;21337.78662213389;21378.893105534684;21386.144554217968;21451.67822482664;7438.012400018038;7629.8855517167285;7745;7757.866586688706;7807.141214466405;1049.37037777333;1076.364944682641;1140.0651465797966;1153.7865494883306;1189.6252680405644;35004.47493287603;35010.64989350074;35194.29611407809;35227.64772352295;35775.105622359646;1093.868735751715;1152.9596464123715;1198.6463993121877;1224.400043978462;1277.8530468995998;18461.261549538136;18593.814061859477;18794.248230070916;18819.623607527774;19043.238270469305;602418;606066;606078;606185;613513;68305.3169468299;68694.65652671705;68755;68858.65570672114;68883;1333.513267657298;1388.6042477893752;1417.4401111561083;1425.4796999095463;1449.7970284160226;34581;36916.63083369239;36943.81528092342;37072.81463592772;37139;55757.721211393684;56234.71882640724;56772.148417774595;56856;57032.42967570271;438955;441544;441728;443522;443952;31237.531437028916;32507.34985300328;32611.673883260864;32778.18054548655;33932.62471626962;54103;54255.45744542504;54847.177292339846;55109;55629.72185139048;45463;46044.53955460402;46061.30908036449;46886;48125;45898.311525327816;46326.76836615795;46408;47087;47518.52481475141;44981.55018449773;45007.54992450165;45906.54093459023;46433.30350044685;46644.53355466537;36977.63022369849;40122.79938600288;41082.383764242964;41308.79345603253;41478.1704365917;30432.695673043872;30539;30889.69110308868;30950;31055.53416698706 04:00:15 INFO - PROCESS | 12847 | |2;jquery.html;395.2391646081293;415.814962341758;426.79300539238466;430.98707038788837;438.07784613388816;15276.694466110672;20665.793342066576;20868.269610563635;21409.46476338092;21624.567508649816;20431.795682043175;20536.691949620767;20545;20564.38306850797;20827.895860520715;5854.795082172125;5914.408559144094;5950.642961422329;5966.403359664042;6000.969995150018;5956.7319470623925;5998.790042348519;6000.3699611540815;6003.249593800775;6003.849903752419;5703.31560212775;5914.2311499505;5938.613990090652;5999.790007349744;6019.097135429677;5961.761529538813;5992.9700351498395;6003.519718422537;6041.486473649745;6110.3889611038985;6010.338862725097;6070.514358851281;6070.757169713206;6072.9696351518405;6080.118382834508;14295.213763243017;14535.345909434101;14744.631384215374;14835.777463338058;14850.108993460426;2392.760723927611;2480.2807185916063;2961.3781105967773;3084.306031142997;3104.301532155247;10287.89712102877;10964.506597203144;11018.669439916735;11066.446438876794;11403;1949.278766856258;1961.7940116287728;1965.1451618545977;1979.297349440942;2092.665173572236;81345.59327203385;90582;90963.09036909613;91301;93657;10859;11102.834947185222;11192.328460292409;11457.369844658624;11710.180287379802;16710.331586736393;16712.665746684997;16724.49826505207;16755.162241887858;16756;8192.918070819216;8282.58587070644;8343.916560834436;8455.661773529113;8654.394192406471;7823.726169584037;7881.724139655199;8025.879611805827;8262.256396924306;8287.709930152536;4947.876303092451;4956.430010548833;4958.479359667255;5093.668911520739;5149.029885698884;2035.9389218323474;2069.244725675118;2093.8588469284277;2108.7258656374574;2127.159771890095;862.4480332587149;947.1333729637443;948.9845864924603;961.423146112327;985.6402413119304;18584.491093702178;19384.224631014884;19923.302684405975;20070.297539586336;20099.59800804005;951.7763325618474;957.5882370580578;959.6545243712258;975.4196253229317;988.5304480371766;10492.737681558023;10968.506417211245;10972.725681858017;11063.336199828036;11105.222634415675;466356;469021;538602;559785;562069;60134.69932650309;61615.691921541;85735.57132214424;98011.50994244983;98639.50680246696;986.4426598971702;1000.6647772995982;1007.2194049611463;1017.7913527726798;1045.1847558904067;17095.91452042732;17170.055646939538;17571.912140439217;17927.551811204823;17983.190756416254;43232.78383608062;44224;44931.55068449405;45199.548004519536;46541;62483;63190.684046579474;63196.368036320884;63373.683131584046;63543;8931.553422328727;9158.084191581054;9170;9231.907680923105;9241.491717955578;11069.335839849635;13638.727225455634;13775.793363099361;13838.515651952133;14268;11409.144314176305;11960.521579136737;12102.394880256128;12134.271943683407;12330.198537095419;11654.184207105422;11728.530858765555;11779.175457717878;12240.081993850676;12308.753824923631;8623.956880215559;11292.717682058013;11586.88413115858;11747.001504872182;11841.28952262867;12938.159019663692;13625.93187034098;13897.374618142007;13981.790273145707;14043.297835108408;12886.09797314179;12898.161619494704;12975.416106275052;12993.480260789462;13525.72948541004 04:00:15 INFO - PROCESS | 12847 | |3;mootools.html;1393.4704812171374;1519.5289460267318;1539.622792415858;1714.6827836850184;1867.281096777741;8479.576021198938;8838;8866.290696744269;9127.68053118141;9130.04134565871;8920.732378028653;9072.63709451621;9073.909260907405;9074.773130671736;9075.36472446929;2456.0912462388897;2473.6907886514186;2481.2060140754966;2481.553320402327;2487.6268559716004;2415.867127307997;2513.183215454975;2513.258588716333;2513.7988960883176;2515.0694243129974;2416.7462416446283;2455.3861534616344;2500.0749722602573;2501.3496490912403;2501.3621526510715;2277.0664027748708;2304.5506126305377;2307.238611258289;2347.518758654489;2351.071326825894;2410.2166795791436;2426.2721183644835;2449.865257410842;2452.227548322273;2456;8972.237359824423;9089.954550227207;9103.226225770752;9104.544772761335;9116.361854670176;5608.915866262009;5849.502792262663;5867.618604790675;5870.706464676792;5880.529557635379;3563.2695297463956;3579.011525376314;3590.4434812604086;3654.031681604377;3656.981715091434;1195.8863907928733;1206.215959626241;1212.9636110916686;1225.497546006142;1244.3591550351575;13292.335383230897;13362.465501379933;13449.529266475627;13452.260125693083;13470.865291347158;4771.976140119346;4794.664373493822;4823;4892.902141957141;4983.90032199354;10556.577736890438;10632.255742098134;10642.574297028186;10657.467126643636;10662.200334974908;5725.026745453283;5733.082706766897;5735;5735.397783232784;5742.052561327334;4669.929951050737;4811.711297322172;5148.742562871841;5198.870028249248;5299.099153143975;4211.663066954637;4256.2551553478015;4295.634871035997;4308.612224899774;4332.176886391576;1256.7612153690952;1272.3638180909545;1284.6575328781446;1284.7366289910547;1289.8323217981601;932.2495391210006;1006.3307900246255;1025.7486915705551;1038.4963292802984;1057.836035414512;6280.403361680633;6312.147860038836;6329.651869147149;6338.080978258126;6652.667366631649;480.8485327121945;482.445188033764;491.94096708394505;498.9700617962934;500.72460146919775;4400.9559904401185;4421.204183246982;4425.3140763181755;4467.503386365604;4476.127155204704;11045.889541104647;11380.715482113013;11666.76666466683;11785.528578856922;11791;11275.210735248455;11464.828027579593;11517.308961462339;11532.36571988532;11559.36423496699;8521.275691566163;8657.783555411164;8660.35047371437;8669.393142480092;8701.912980870236;6595;6715.529912906245;6740.427063699641;6825.89761153593;6853.9314606853295;10579.725359047534;10816.459177040959;10870;10871.728206794576;10900.618478353219;9088.591013404544;10620.628278010232;10743.086837618577;10809.729756756144;10948;8355.958220209102;8500.617472213642;8565.828683426173;8567.957160214159;8572.657093716181;9028.81942361136;9034.638614455349;9067.591958361758;9074.228690561113;9096.681616143404;7882.487638303492;7927.881081783663;8020.358371330396;8211.917880821115;8305;7693.538387696756;7854.607269636381;7967.840643186988;8018.158093400342;8048.718294859652;7399.556026638419;7454;7503.399728021636;7506.13679426851;7520.548767073993;5539.975104605661;5540.972295138498;5623.493885550321;5642.125470552071;5699.316082070012;5332.893342133058;5336.466353364633;5402.540784033401;5470.507654311131;5620.915686264628 04:00:15 INFO - PROCESS | 12847 | |4;prototype.html;349.5839950458954;351.0609120602388;351.9190586165181;353.55805243445695;357.8300307354009;5493.423190564993;5503.972480137599;5565.638233514819;5574.358948720898;5575.470330318613;5445.128779395298;5449.863753406167;5483.506484416402;5495.258140151079;5496.148097044955;3855.595162507924;4104.6921480888905;4301.827926882921;4318.460192475941;4327.935080973788;4309.427059123413;4311.741295522263;4325.351197320396;4332.913341733163;4341.110072435159;4254.4043833863125;4305.806238719265;4317.935230971538;4324.654027677794;4355.281378572532;4155.896102597429;4221.894452638693;4310.568943105695;4337.587929146726;4354.107407981356;3813.8474461021524;3822.1591249924973;3833.3291673957224;3836;3871.606221760164;5259.86850328741;5296.040465027926;5338.412774594792;5346.770242844168;5359.892802143974;4854.587360074363;4926.482719314492;4927.039227350668;4935.605151587864;4999.600031997432;5647.8588035299035;5648.43515648436;5649.8587535311535;5651;5663.886722265532;4201.390798334255;4201.432806571104;4208.200441916026;4240.279152544075;4245.830166793325;5652.830415087554;5752.884942301131;5796.507296879812;5891.823245302648;5897.469227769521;4265;4277.871663850089;4297.806598703003;4299.78501074945;4312.633426158812;4364.454443194601;4365.301551751768;4367.825286988548;4368.301071828492;4383.473983122046;4806.327114204014;4888.584470319992;4917.58200552957;4921;4939.5554400104165;5719.57103217252;5725.799597014085;5732.914006289909;5739.311282646109;5760.8271751847515;1497.8427265137223;1516.150955464943;1518.9240537973058;1519.384649217069;1522.7944227529363;937.5218638494417;971.5433746139303;979.1383582447543;990.3810118675827;991.7718924647227;4872.930054065987;4876.512348765095;4887.266909963534;4900.480850936221;4938.580220681282;5084.068054139403;5093.752030752489;5104.3874735031295;5151.042603810603;5164.147915593885;4605.585497305258;4871.29366241893;4897.2898929655;4929.75351232437;4935.629827762932;2732.5901114832536;2734.371094648242;2749.0344403751415;2761.792865535053;2775.639936431134;5268.315119034501;5309.619498930306;5330.840074797762;5361.597880159004;5362.302900622894;5136.383633963948;5156.819511317086;5597.972010139923;6081.209442772411;6087.543434242361;6196.132541444202;6199.690015499207;6202.131701561785;6206.596571222856;6216.813495595049;5916.290045194604;5923.49650279731;5992.43071908168;6063.484128967758;6077.574569780073;5854.619449735754;5866.354700982974;5907.556933229939;5917.3490915998345;5925.733341999534;5901.675407852437;6005.219321488178;6009.87980240384;6022;6135.159452164244;3982.1637456133376;4158;4194.098268872207;4199.496060472763;4215.662746980295;5879.118132280021;5911.793087241926;5917.112433135064;5927.881442371215;5944.851378715393;5712.457956209447;5824.204381896629;5837.67892765902;5864.530837532901;5872.383399742966;5652.293463317085;5668.404817494269;5721.828345149652;5773.653580785166;5783.913241301299;5689.7439615218245;5705.34388545306;5706.115552089433;5709.942900570941;5794.971025144847;5709.486146246858;5712.742926568231;5779.566532510163;5797.188393624981;5878.647281163144;5662.518685911744;5663.490285874291;5669.829905102853;5675.318961724454;5738.512226460798 04:00:15 INFO - PROCESS | 12847 | |5;yui.html;781.6091954022988;798.4610387988107;806.7337778533084;828.2256090555331;842.2714352085446;16149.919250403746;16820.831791682078;17346.392876249334;17619.823801761977;17869.7319540207;16461.83538164618;16471.258793354296;16545;16637.584060398494;16728.330866765344;739.0872272743185;855.3798496090347;875.4572165257549;876.3120950054209;886.3751055505853;875.4090988582712;883.4699180491718;883.765802062454;883.8011447424342;883.9116088391141;924.1636319131197;934.2105920497169;934.2992755433424;934.313279739391;934.9672761453351;760.4334770595914;906.2387594420652;931.2782593490032;931.483026920059;934.0939288889766;683.8290427393151;683.8392977650249;684.1755684400335;684.336193891929;685.4276678973064;15552.222388880511;15572.221388930508;15603.765943510856;15607.45373911919;15638.530844074696;14809.481668141563;14968.47610333644;14973.850261497355;15014.24928753569;15035.924820375938;13251.536196233183;13308;13376.130551514121;13510.797338039938;13725.794113088312;4499.280115181556;4577.748223847687;4578.545393149087;4592.2193227151465;4659.301104834268;85712.57143714304;86704.56647716784;87912;88070.559647202;90675.09324906733;11101.5559377624;11271;11273.492692828842;11334.206605537698;11437.199396042197;21625.35123946284;21643.67534486984;21661;21676.45808854791;21772.56454870894;8483.151684831468;8716.564171791386;8795.296376289882;8800.251978581764;9193.034731353246;4970.8757281068265;4988.152014157602;5023.120953833065;5123.2827404163445;5132.871678208075;3607.3687104756564;3716.9070773230887;3720.069982504374;3725.720570957189;3742.3825068863875;653.9705713242915;658.4271683635172;664.51158398577;666.4401902401909;670.0184230102923;661.1999480628398;708.914930208368;709.2517394149222;734.3757805865079;737.0087232672048;9169.40398874071;9682.322237443312;9801;9833.60665573369;10179.338343007681;612.4059662127729;650.3593959949446;694.9548279361825;711.6299524247362;773.1263672050546;4586.816527338936;4608.9308660370125;4611.792469338888;4616.238320677051;4657.976710116428;127742;133254;135989;138446;139090.30454847662;108893.45553272341;110649;112921;116162.41918790352;119208;100954;104970.4751476253;105203;105789;106709;9125.361224714206;9132.49771262587;9172.495512746864;9187;9247.815043699224;58098.7095064522;58785.70607146937;60122;61275.08087378782;62571;84136;91293.54353228191;91806;93492;95226;11859.110566707359;11934.343611101125;11968.880311196777;12583.370831458207;12720.6819829505;12303.507859685513;12700.936495317465;12969.027322950627;13248.602541923758;13383.19700817954;12491.875081249435;12742.426590803621;13305.534306299232;13472.056956012984;13713.657158571115;12297.815532767194;12595.93702031484;12705.237685738884;13157.276349800853;13284.933575332061;11600.6519804406;11622.82565761531;11696.766064678828;11758.58844940423;12031.15781895259;10675.839862402225;10832.079273261861;10906.672799816019;10919.945400272947;11064.889351106385;10474.319169253975;10569.639782217218;10800.513976870903;10800.783984320427;10929 04:00:15 INFO - PROCESS | 12847 | __end_tp_report 04:00:15 INFO - PROCESS | 12847 | __start_cc_report 04:00:15 INFO - PROCESS | 12847 | _x_x_mozilla_cycle_collect,1184 04:00:15 INFO - PROCESS | 12847 | __end_cc_report 04:00:15 INFO - PROCESS | 12847 | __startTimestamp1474023615913__endTimestamp 04:00:15 INFO - PROCESS | 12847 | 04:00:15 INFO - PROCESS | 12847 | ------- Summary: start ------- 04:00:15 INFO - PROCESS | 12847 | Number of tests: 6 04:00:15 INFO - PROCESS | 12847 | 04:00:15 INFO - PROCESS | 12847 | [#0] dojo.html Cycles:165 Average:5527.70 Median:5697.43 stddev:617.62 (10.8%) stddev-sans-first:592.72 04:00:15 INFO - PROCESS | 12847 | Values: 3234.0 3236.2 3263.6 3287.8 3303.5 5520.8 5541.6 5599.1 5604.8 5619.7 5571.1 5619.7 5629.8 5646.5 5677.1 5009.1 5070.4 5102.1 5174.8 5188.7 4972.4 5085.9 5115.1 5134.4 5154.6 5043.8 5066.8 5082.9 5086.8 5134.4 5152.4 5193.3 5197.6 5202.9 5229.6 4896.6 4932.1 4948.4 5080.8 5083.8 5507.7 5514.9 5536.0 5538.0 5541.6 6044.0 6049.7 6050.1 6052.2 6058.8 5948.6 5987.9 6009.7 6041.5 6065.5 5618.4 5623.0 5634.1 5641.6 5668.4 5937.6 6190.4 6194.9 6201.4 6207.5 5825.3 5852.4 5869.3 5940.5 5952.0 5995.1 5996.0 6005.1 6009.8 6028.4 5738.5 5970.4 5991.6 6002.1 6002.4 5807.2 5840.9 5844.8 5898.7 5936.9 4517.6 4532.0 4535.1 4537.6 4562.9 4027.2 4088.0 4096.4 4097.7 4137.7 5477.3 5593.7 5606.8 5715.8 5731.1 5881.6 5919.2 5941.8 5959.3 5965.8 5653.2 5665.5 5667.5 5683.0 5685.1 4957.3 5019.4 5030.7 5036.0 5106.9 6052.3 6053.6 6054.8 6066.5 6067.8 5833.9 5841.5 5843.4 5851.8 5857.1 6014.0 6116.8 6136.9 6142.2 6230.2 5900.2 5912.3 5919.1 5920.4 5921.8 5964.4 6001.8 6010.9 6020.2 6024.7 5649.9 5671.8 5672.4 5725.5 5906.5 5700.7 5710.9 5712.6 5722.3 5741.9 5609.1 5658.4 5658.5 5669.5 5669.6 5682.6 5718.6 5736.4 5807.2 5826.2 5697.4 5702.8 5708.8 5727.1 5729.1 04:00:15 INFO - PROCESS | 12847 | 04:00:15 INFO - PROCESS | 12847 | [#1] ext.html Cycles:180 Average:65810.71 Median:22066.37 stddev:129430.79 (586.6%) stddev-sans-first:129701.23 04:00:15 INFO - PROCESS | 12847 | Values: 585.4 629.9 638.7 640.0 666.2 46514.8 48636.8 48726.5 48745.5 52842.0 49878.5 50337.0 50369.7 50386.0 50386.7 8948.5 9421.5 9518.4 9577.5 9579.5 11152.8 11491.3 11499.0 11866.8 11871.0 11632.9 11673.5 11691.3 11699.2 11708.2 11427.0 11464.9 11465.3 11476.3 11482.9 11233.8 11276.9 11324.1 11341.1 11341.3 46710.5 47038.5 47065.8 47114.9 47138.5 3818.8 3857.3 3871.5 4009.9 4164.3 35314.6 35460.5 35512.1 35557.0 35716.8 4785.8 4855.4 4904.8 4912.0 4963.7 386576.0 389330.0 389482.0 390740.0 392592.0 66046.0 66711.0 66765.3 66765.7 66864.0 39987.8 41350.8 41363.4 43248.0 43316.0 17257.0 17426.4 17459.3 17498.7 17515.3 10515.3 12137.3 12219.3 12797.4 13134.5 21075.0 21337.8 21378.9 21386.1 21451.7 7438.0 7629.9 7745.0 7757.9 7807.1 1049.4 1076.4 1140.1 1153.8 1189.6 35004.5 35010.6 35194.3 35227.6 35775.1 1093.9 1153.0 1198.6 1224.4 1277.9 18461.3 18593.8 18794.2 18819.6 19043.2 602418.0 606066.0 606078.0 606185.0 613513.0 68305.3 68694.7 68755.0 68858.7 68883.0 1333.5 1388.6 1417.4 1425.5 1449.8 34581.0 36916.6 36943.8 37072.8 37139.0 55757.7 56234.7 56772.1 56856.0 57032.4 438955.0 441544.0 441728.0 443522.0 443952.0 31237.5 32507.3 32611.7 32778.2 33932.6 54103.0 54255.5 54847.2 55109.0 55629.7 45463.0 46044.5 46061.3 46886.0 48125.0 45898.3 46326.8 46408.0 47087.0 47518.5 44981.6 45007.5 45906.5 46433.3 46644.5 36977.6 40122.8 41082.4 41308.8 41478.2 30432.7 30539.0 30889.7 30950.0 31055.5 04:00:15 INFO - PROCESS | 12847 | 04:00:15 INFO - PROCESS | 12847 | [#2] jquery.html Cycles:180 Average:30154.30 Median:3022.84 stddev:85754.19 (2836.9%) stddev-sans-first:85965.64 04:00:15 INFO - PROCESS | 12847 | Values: 395.2 415.8 426.8 431.0 438.1 15276.7 20665.8 20868.3 21409.5 21624.6 20431.8 20536.7 20545.0 20564.4 20827.9 5854.8 5914.4 5950.6 5966.4 6001.0 5956.7 5998.8 6000.4 6003.2 6003.8 5703.3 5914.2 5938.6 5999.8 6019.1 5961.8 5993.0 6003.5 6041.5 6110.4 6010.3 6070.5 6070.8 6073.0 6080.1 14295.2 14535.3 14744.6 14835.8 14850.1 2392.8 2480.3 2961.4 3084.3 3104.3 10287.9 10964.5 11018.7 11066.4 11403.0 1949.3 1961.8 1965.1 1979.3 2092.7 81345.6 90582.0 90963.1 91301.0 93657.0 10859.0 11102.8 11192.3 11457.4 11710.2 16710.3 16712.7 16724.5 16755.2 16756.0 8192.9 8282.6 8343.9 8455.7 8654.4 7823.7 7881.7 8025.9 8262.3 8287.7 4947.9 4956.4 4958.5 5093.7 5149.0 2035.9 2069.2 2093.9 2108.7 2127.2 862.4 947.1 949.0 961.4 985.6 18584.5 19384.2 19923.3 20070.3 20099.6 951.8 957.6 959.7 975.4 988.5 10492.7 10968.5 10972.7 11063.3 11105.2 466356.0 469021.0 538602.0 559785.0 562069.0 60134.7 61615.7 85735.6 98011.5 98639.5 986.4 1000.7 1007.2 1017.8 1045.2 17095.9 17170.1 17571.9 17927.6 17983.2 43232.8 44224.0 44931.6 45199.5 46541.0 62483.0 63190.7 63196.4 63373.7 63543.0 8931.6 9158.1 9170.0 9231.9 9241.5 11069.3 13638.7 13775.8 13838.5 14268.0 11409.1 11960.5 12102.4 12134.3 12330.2 11654.2 11728.5 11779.2 12240.1 12308.8 8624.0 11292.7 11586.9 11747.0 11841.3 12938.2 13625.9 13897.4 13981.8 14043.3 12886.1 12898.2 12975.4 12993.5 13525.7 04:00:15 INFO - PROCESS | 12847 | 04:00:15 INFO - PROCESS | 12847 | [#3] mootools.html Cycles:180 Average:6130.82 Median:2637.76 stddev:3495.90 (132.5%) stddev-sans-first:3487.58 04:00:15 INFO - PROCESS | 12847 | Values: 1393.5 1519.5 1539.6 1714.7 1867.3 8479.6 8838.0 8866.3 9127.7 9130.0 8920.7 9072.6 9073.9 9074.8 9075.4 2456.1 2473.7 2481.2 2481.6 2487.6 2415.9 2513.2 2513.3 2513.8 2515.1 2416.7 2455.4 2500.1 2501.3 2501.4 2277.1 2304.6 2307.2 2347.5 2351.1 2410.2 2426.3 2449.9 2452.2 2456.0 8972.2 9090.0 9103.2 9104.5 9116.4 5608.9 5849.5 5867.6 5870.7 5880.5 3563.3 3579.0 3590.4 3654.0 3657.0 1195.9 1206.2 1213.0 1225.5 1244.4 13292.3 13362.5 13449.5 13452.3 13470.9 4772.0 4794.7 4823.0 4892.9 4983.9 10556.6 10632.3 10642.6 10657.5 10662.2 5725.0 5733.1 5735.0 5735.4 5742.1 4669.9 4811.7 5148.7 5198.9 5299.1 4211.7 4256.3 4295.6 4308.6 4332.2 1256.8 1272.4 1284.7 1284.7 1289.8 932.2 1006.3 1025.7 1038.5 1057.8 6280.4 6312.1 6329.7 6338.1 6652.7 480.8 482.4 491.9 499.0 500.7 4401.0 4421.2 4425.3 4467.5 4476.1 11045.9 11380.7 11666.8 11785.5 11791.0 11275.2 11464.8 11517.3 11532.4 11559.4 8521.3 8657.8 8660.4 8669.4 8701.9 6595.0 6715.5 6740.4 6825.9 6853.9 10579.7 10816.5 10870.0 10871.7 10900.6 9088.6 10620.6 10743.1 10809.7 10948.0 8356.0 8500.6 8565.8 8568.0 8572.7 9028.8 9034.6 9067.6 9074.2 9096.7 7882.5 7927.9 8020.4 8211.9 8305.0 7693.5 7854.6 7967.8 8018.2 8048.7 7399.6 7454.0 7503.4 7506.1 7520.5 5540.0 5541.0 5623.5 5642.1 5699.3 5332.9 5336.5 5402.5 5470.5 5620.9 04:00:15 INFO - PROCESS | 12847 | 04:00:15 INFO - PROCESS | 12847 | [#4] prototype.html Cycles:180 Average:4762.32 Median:5320.23 stddev:1394.65 (26.2%) stddev-sans-first:1358.67 04:00:15 INFO - PROCESS | 12847 | Values: 349.6 351.1 351.9 353.6 357.8 5493.4 5504.0 5565.6 5574.4 5575.5 5445.1 5449.9 5483.5 5495.3 5496.1 3855.6 4104.7 4301.8 4318.5 4327.9 4309.4 4311.7 4325.4 4332.9 4341.1 4254.4 4305.8 4317.9 4324.7 4355.3 4155.9 4221.9 4310.6 4337.6 4354.1 3813.8 3822.2 3833.3 3836.0 3871.6 5259.9 5296.0 5338.4 5346.8 5359.9 4854.6 4926.5 4927.0 4935.6 4999.6 5647.9 5648.4 5649.9 5651.0 5663.9 4201.4 4201.4 4208.2 4240.3 4245.8 5652.8 5752.9 5796.5 5891.8 5897.5 4265.0 4277.9 4297.8 4299.8 4312.6 4364.5 4365.3 4367.8 4368.3 4383.5 4806.3 4888.6 4917.6 4921.0 4939.6 5719.6 5725.8 5732.9 5739.3 5760.8 1497.8 1516.2 1518.9 1519.4 1522.8 937.5 971.5 979.1 990.4 991.8 4872.9 4876.5 4887.3 4900.5 4938.6 5084.1 5093.8 5104.4 5151.0 5164.1 4605.6 4871.3 4897.3 4929.8 4935.6 2732.6 2734.4 2749.0 2761.8 2775.6 5268.3 5309.6 5330.8 5361.6 5362.3 5136.4 5156.8 5598.0 6081.2 6087.5 6196.1 6199.7 6202.1 6206.6 6216.8 5916.3 5923.5 5992.4 6063.5 6077.6 5854.6 5866.4 5907.6 5917.3 5925.7 5901.7 6005.2 6009.9 6022.0 6135.2 3982.2 4158.0 4194.1 4199.5 4215.7 5879.1 5911.8 5917.1 5927.9 5944.9 5712.5 5824.2 5837.7 5864.5 5872.4 5652.3 5668.4 5721.8 5773.7 5783.9 5689.7 5705.3 5706.1 5709.9 5795.0 5709.5 5712.7 5779.6 5797.2 5878.6 5662.5 5663.5 5669.8 5675.3 5738.5 04:00:15 INFO - PROCESS | 12847 | 04:00:15 INFO - PROCESS | 12847 | [#5] yui.html Cycles:180 Average:23339.96 Median:4120.83 stddev:35586.70 (863.6%) stddev-sans-first:35646.22 04:00:15 INFO - PROCESS | 12847 | Values: 781.6 798.5 806.7 828.2 842.3 16149.9 16820.8 17346.4 17619.8 17869.7 16461.8 16471.3 16545.0 16637.6 16728.3 739.1 855.4 875.5 876.3 886.4 875.4 883.5 883.8 883.8 883.9 924.2 934.2 934.3 934.3 935.0 760.4 906.2 931.3 931.5 934.1 683.8 683.8 684.2 684.3 685.4 15552.2 15572.2 15603.8 15607.5 15638.5 14809.5 14968.5 14973.9 15014.2 15035.9 13251.5 13308.0 13376.1 13510.8 13725.8 4499.3 4577.7 4578.5 4592.2 4659.3 85712.6 86704.6 87912.0 88070.6 90675.1 11101.6 11271.0 11273.5 11334.2 11437.2 21625.4 21643.7 21661.0 21676.5 21772.6 8483.2 8716.6 8795.3 8800.3 9193.0 4970.9 4988.2 5023.1 5123.3 5132.9 3607.4 3716.9 3720.1 3725.7 3742.4 654.0 658.4 664.5 666.4 670.0 661.2 708.9 709.3 734.4 737.0 9169.4 9682.3 9801.0 9833.6 10179.3 612.4 650.4 695.0 711.6 773.1 4586.8 4608.9 4611.8 4616.2 4658.0 127742.0 133254.0 135989.0 138446.0 139090.3 108893.5 110649.0 112921.0 116162.4 119208.0 100954.0 104970.5 105203.0 105789.0 106709.0 9125.4 9132.5 9172.5 9187.0 9247.8 58098.7 58785.7 60122.0 61275.1 62571.0 84136.0 91293.5 91806.0 93492.0 95226.0 11859.1 11934.3 11968.9 12583.4 12720.7 12303.5 12700.9 12969.0 13248.6 13383.2 12491.9 12742.4 13305.5 13472.1 13713.7 12297.8 12595.9 12705.2 13157.3 13284.9 11600.7 11622.8 11696.8 11758.6 12031.2 10675.8 10832.1 10906.7 10919.9 11064.9 10474.3 10569.6 10800.5 10800.8 10929.0 04:00:15 INFO - PROCESS | 12847 | -------- Summary: end -------- 04:00:15 INFO - PROCESS | 12847 | 04:00:16 INFO - TEST-INFO | 12847: exit 0 04:00:16 INFO - TEST-OK | dromaeo_css | took 1113287ms 04:00:16 INFO - TEST-START | kraken 04:00:16 INFO - operating with platform_type : linux_ 04:00:16 INFO - Initialising browser for kraken test... 04:00:16 INFO - TEST-INFO | started process 13052 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLDdrQG/profile http://localhost:40157/getInfo.html) 04:00:20 INFO - PROCESS | 13052 | __metrics Screen width/height:1600/1200 04:00:20 INFO - PROCESS | 13052 | colorDepth:24 04:00:20 INFO - PROCESS | 13052 | Browser inner width/height: 1024/697 04:00:20 INFO - PROCESS | 13052 | __metrics 04:00:21 INFO - PROCESS | 13052 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:00:21 INFO - PROCESS | 13052 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:00:22 INFO - TEST-INFO | 13052: exit 0 04:00:22 INFO - Browser initialized. 04:00:22 INFO - Running cycle 1/1 for kraken test... 04:00:22 INFO - TEST-INFO | started process 13144 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLDdrQG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:00:34 INFO - PROCESS | 13144 | RSS: Main: 146190336 04:00:34 INFO - PROCESS | 13144 | 04:00:36 INFO - PROCESS | 13144 | Cycle 1(1): loaded http://localhost:40157/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40157/tests/kraken/driver.html?testName=audio-beat-detection) 04:00:37 INFO - PROCESS | 13144 | RSS: Main: 200486912 04:00:37 INFO - PROCESS | 13144 | 04:00:40 INFO - PROCESS | 13144 | Cycle 1(1): loaded http://localhost:40157/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40157/tests/kraken/driver.html?testName=audio-dft) 04:00:40 INFO - PROCESS | 13144 | RSS: Main: 185245696 04:00:40 INFO - PROCESS | 13144 | 04:00:43 INFO - PROCESS | 13144 | Cycle 1(1): loaded http://localhost:40157/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40157/tests/kraken/driver.html?testName=audio-fft) 04:00:44 INFO - PROCESS | 13144 | RSS: Main: 275767296 04:00:44 INFO - PROCESS | 13144 | 04:00:46 INFO - PROCESS | 13144 | Cycle 1(1): loaded http://localhost:40157/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40157/tests/kraken/driver.html?testName=audio-oscillator) 04:00:46 INFO - PROCESS | 13144 | RSS: Main: 182157312 04:00:46 INFO - PROCESS | 13144 | 04:00:48 INFO - PROCESS | 13144 | Cycle 1(1): loaded http://localhost:40157/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40157/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:00:49 INFO - PROCESS | 13144 | RSS: Main: 181440512 04:00:49 INFO - PROCESS | 13144 | 04:00:52 INFO - PROCESS | 13144 | Cycle 1(1): loaded http://localhost:40157/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40157/tests/kraken/driver.html?testName=imaging-darkroom) 04:00:53 INFO - PROCESS | 13144 | RSS: Main: 216797184 04:00:53 INFO - PROCESS | 13144 | 04:00:56 INFO - PROCESS | 13144 | Cycle 1(1): loaded http://localhost:40157/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40157/tests/kraken/driver.html?testName=imaging-desaturate) 04:00:57 INFO - PROCESS | 13144 | RSS: Main: 215035904 04:00:57 INFO - PROCESS | 13144 | 04:00:59 INFO - PROCESS | 13144 | Cycle 1(1): loaded http://localhost:40157/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40157/tests/kraken/driver.html?testName=json-parse-financial) 04:01:00 INFO - PROCESS | 13144 | RSS: Main: 215801856 04:01:00 INFO - PROCESS | 13144 | 04:01:01 INFO - PROCESS | 13144 | Cycle 1(1): loaded http://localhost:40157/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40157/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:01:02 INFO - PROCESS | 13144 | RSS: Main: 178044928 04:01:02 INFO - PROCESS | 13144 | 04:01:04 INFO - PROCESS | 13144 | Cycle 1(1): loaded http://localhost:40157/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40157/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:01:04 INFO - PROCESS | 13144 | RSS: Main: 185053184 04:01:04 INFO - PROCESS | 13144 | 04:01:06 INFO - PROCESS | 13144 | Cycle 1(1): loaded http://localhost:40157/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40157/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:01:07 INFO - PROCESS | 13144 | RSS: Main: 187060224 04:01:07 INFO - PROCESS | 13144 | 04:01:10 INFO - PROCESS | 13144 | Cycle 1(1): loaded http://localhost:40157/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40157/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:01:10 INFO - PROCESS | 13144 | RSS: Main: 187428864 04:01:10 INFO - PROCESS | 13144 | 04:01:13 INFO - PROCESS | 13144 | Cycle 1(1): loaded http://localhost:40157/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40157/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:01:13 INFO - PROCESS | 13144 | RSS: Main: 185520128 04:01:13 INFO - PROCESS | 13144 | 04:01:15 INFO - PROCESS | 13144 | Cycle 1(1): loaded http://localhost:40157/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40157/tests/kraken/driver.html?testName=ai-astar) 04:01:15 INFO - PROCESS | 13144 | RSS: Main: 236593152 04:01:15 INFO - PROCESS | 13144 | 04:01:15 INFO - PROCESS | 13144 | __start_tp_report 04:01:15 INFO - PROCESS | 13144 | _x_x_mozilla_page_load 04:01:15 INFO - PROCESS | 13144 | _x_x_mozilla_page_load_details 04:01:15 INFO - PROCESS | 13144 | |i|pagename|runs| 04:01:15 INFO - PROCESS | 13144 | |0;ai-astar;110;110;118;111;114;110;110;109;110;112 04:01:15 INFO - PROCESS | 13144 | |1;audio-beat-detection;140;115;139;165;119;150;138;119;175;115 04:01:15 INFO - PROCESS | 13144 | |2;audio-dft;162;160;160;159;161;161;162;160;160;160 04:01:15 INFO - PROCESS | 13144 | |3;audio-fft;74;74;74;180;76;75;74;76;156;76 04:01:15 INFO - PROCESS | 13144 | |4;audio-oscillator;83;83;160;84;84;84;139;83;83;147 04:01:15 INFO - PROCESS | 13144 | |5;imaging-gaussian-blur;117;116;117;116;116;116;117;116;116;117 04:01:15 INFO - PROCESS | 13144 | |6;imaging-darkroom;146;145;146;146;146;146;146;146;146;145 04:01:15 INFO - PROCESS | 13144 | |7;imaging-desaturate;94;97;95;95;95;95;94;95;94;95 04:01:15 INFO - PROCESS | 13144 | |8;json-parse-financial;51;54;50;51;51;51;52;51;51;51 04:01:15 INFO - PROCESS | 13144 | |9;json-stringify-tinderbox;60;61;66;61;61;61;65;61;61;61 04:01:15 INFO - PROCESS | 13144 | |10;stanford-crypto-aes;73;74;73;76;81;72;81;75;81;72 04:01:15 INFO - PROCESS | 13144 | |11;stanford-crypto-ccm;129;116;118;117;114;118;116;120;159;121 04:01:15 INFO - PROCESS | 13144 | |12;stanford-crypto-pbkdf2;157;158;155;153;154;152;152;161;150;152 04:01:15 INFO - PROCESS | 13144 | |13;stanford-crypto-sha256-iterative;64;61;62;64;67;64;63;62;64;62 04:01:15 INFO - PROCESS | 13144 | __end_tp_report 04:01:15 INFO - PROCESS | 13144 | __start_cc_report 04:01:15 INFO - PROCESS | 13144 | _x_x_mozilla_cycle_collect,1654 04:01:15 INFO - PROCESS | 13144 | __end_cc_report 04:01:15 INFO - PROCESS | 13144 | __startTimestamp1474023675768__endTimestamp 04:01:15 INFO - PROCESS | 13144 | 04:01:15 INFO - PROCESS | 13144 | ------- Summary: start ------- 04:01:15 INFO - PROCESS | 13144 | Number of tests: 14 04:01:15 INFO - PROCESS | 13144 | 04:01:15 INFO - PROCESS | 13144 | [#0] ai-astar Cycles:10 Average:111.40 Median:110.50 stddev:2.72 (2.5%) stddev-sans-first:2.83 04:01:15 INFO - PROCESS | 13144 | Values: 110.0 110.0 118.0 111.0 114.0 110.0 110.0 109.0 110.0 112.0 04:01:15 INFO - PROCESS | 13144 | 04:01:15 INFO - PROCESS | 13144 | [#1] audio-beat-detection Cycles:10 Average:137.50 Median:139.50 stddev:21.15 (15.2%) stddev-sans-first:22.41 04:01:15 INFO - PROCESS | 13144 | Values: 140.0 115.0 139.0 165.0 119.0 150.0 138.0 119.0 175.0 115.0 04:01:15 INFO - PROCESS | 13144 | 04:01:15 INFO - PROCESS | 13144 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:0.97 (0.6%) stddev-sans-first:0.87 04:01:15 INFO - PROCESS | 13144 | Values: 162.0 160.0 160.0 159.0 161.0 161.0 162.0 160.0 160.0 160.0 04:01:15 INFO - PROCESS | 13144 | 04:01:15 INFO - PROCESS | 13144 | [#3] audio-fft Cycles:10 Average:93.50 Median:74.50 stddev:39.68 (53.3%) stddev-sans-first:41.45 04:01:15 INFO - PROCESS | 13144 | Values: 74.0 74.0 74.0 180.0 76.0 75.0 74.0 76.0 156.0 76.0 04:01:15 INFO - PROCESS | 13144 | 04:01:15 INFO - PROCESS | 13144 | [#4] audio-oscillator Cycles:10 Average:103.00 Median:83.00 stddev:31.91 (38.4%) stddev-sans-first:33.01 04:01:15 INFO - PROCESS | 13144 | Values: 83.0 83.0 160.0 84.0 84.0 84.0 139.0 83.0 83.0 147.0 04:01:15 INFO - PROCESS | 13144 | 04:01:15 INFO - PROCESS | 13144 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 04:01:15 INFO - PROCESS | 13144 | Values: 117.0 116.0 117.0 116.0 116.0 116.0 117.0 116.0 116.0 117.0 04:01:15 INFO - PROCESS | 13144 | 04:01:15 INFO - PROCESS | 13144 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 04:01:15 INFO - PROCESS | 13144 | Values: 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 04:01:15 INFO - PROCESS | 13144 | 04:01:15 INFO - PROCESS | 13144 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.88 (0.9%) stddev-sans-first:0.87 04:01:15 INFO - PROCESS | 13144 | Values: 94.0 97.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 04:01:15 INFO - PROCESS | 13144 | 04:01:15 INFO - PROCESS | 13144 | [#8] json-parse-financial Cycles:10 Average:51.30 Median:51.00 stddev:1.06 (2.1%) stddev-sans-first:1.12 04:01:15 INFO - PROCESS | 13144 | Values: 51.0 54.0 50.0 51.0 51.0 51.0 52.0 51.0 51.0 51.0 04:01:15 INFO - PROCESS | 13144 | 04:01:15 INFO - PROCESS | 13144 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:61.00 stddev:1.99 (3.3%) stddev-sans-first:2.00 04:01:15 INFO - PROCESS | 13144 | Values: 60.0 61.0 66.0 61.0 61.0 61.0 65.0 61.0 61.0 61.0 04:01:15 INFO - PROCESS | 13144 | 04:01:15 INFO - PROCESS | 13144 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:75.50 stddev:3.79 (5.0%) stddev-sans-first:3.89 04:01:15 INFO - PROCESS | 13144 | Values: 73.0 74.0 73.0 76.0 81.0 72.0 81.0 75.0 81.0 72.0 04:01:15 INFO - PROCESS | 13144 | 04:01:15 INFO - PROCESS | 13144 | [#11] stanford-crypto-ccm Cycles:10 Average:122.80 Median:119.00 stddev:13.37 (11.2%) stddev-sans-first:14.00 04:01:15 INFO - PROCESS | 13144 | Values: 129.0 116.0 118.0 117.0 114.0 118.0 116.0 120.0 159.0 121.0 04:01:15 INFO - PROCESS | 13144 | 04:01:15 INFO - PROCESS | 13144 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.40 Median:154.50 stddev:3.37 (2.2%) stddev-sans-first:3.44 04:01:15 INFO - PROCESS | 13144 | Values: 157.0 158.0 155.0 153.0 154.0 152.0 152.0 161.0 150.0 152.0 04:01:15 INFO - PROCESS | 13144 | 04:01:15 INFO - PROCESS | 13144 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:64.00 stddev:1.70 (2.7%) stddev-sans-first:1.79 04:01:15 INFO - PROCESS | 13144 | Values: 64.0 61.0 62.0 64.0 67.0 64.0 63.0 62.0 64.0 62.0 04:01:15 INFO - PROCESS | 13144 | -------- Summary: end -------- 04:01:15 INFO - PROCESS | 13144 | 04:01:16 INFO - TEST-INFO | 13144: exit 0 04:01:16 INFO - TEST-OK | kraken | took 60113ms 04:01:16 INFO - SUITE-END | took 1173s 04:01:16 INFO - Completed test suite (00:19:33) 04:01:16 INFO - javascript benchmark 04:01:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3233.983830080849, 3236.2233064064626, 3263.6409994900555, 3287.7534184936135, 3303.4879593662977, 5520.751566179521, 5541.63979341343, 5599.104143337072, 5604.831855044345, 5619.690916999563, 5571.052921003429, 5619.662820230778, 5629.774809007645, 5646.548276137909, 5677.091665333547, 5009.12340340439, 5070.391553013644, 5102.132637451624, 5174.793008279665, 5188.662736922107, 4972.378452693413, 5085.949140508585, 5115.053715062725, 5134.435212126663, 5154.561862241695, 5043.84868453947, 5066.797328106872, 5082.872928176806, 5086.796528138889, 5134.4095429025765, 5152.381714194302, 5193.298904647862, 5197.558207552324, 5202.947970520322, 5229.555487783543, 4896.608271338285, 4932.136876046713, 4948.406191257036, 5080.847574572768, 5083.79664813407, 5507.669539827583, 5514.889702205934, 5536.031194540939, 5538.030844602178, 5541.639793413456, 6043.969780151115, 6049.727762250709, 6050.062240352752, 6052.152698622196, 6058.787942422038, 5948.643081415129, 5987.850303742398, 6009.729562169713, 6041.486473649745, 6065.4844338231305, 5618.410066942994, 5622.971885140548, 5634.126710359901, 5641.605087643908, 5668.43315668434, 5937.584369094122, 6190.41191086846, 6194.876102477925, 6201.410865967726, 6207.503399728102, 5825.271841019872, 5852.414758524199, 5869.325027621793, 5940.524758019348, 5951.970240148771, 5995.100734889801, 5995.970020149872, 6005.069214271794, 6009.789657361971, 6028.4272994065495, 5738.454846789548, 5970.373110823388, 5991.640501569833, 6002.129691194839, 6002.369751176151, 5807.157962095473, 5840.912386314209, 5844.795432159939, 5898.705064746746, 5936.8812623748145, 4517.593416592523, 4532.0, 4535.138323718483, 4537.6143027842345, 4562.8631141065825, 4027.2146931348107, 4088.0188754698656, 4096.446979657768, 4097.672186225095, 4137.668986481074, 5477.315335583052, 5593.664380137205, 5606.803761868397, 5715.828525144252, 5731.0543760279925, 5881.588548695015, 5919.200907877382, 5941.762329506858, 5959.314678811992, 5965.761369545169, 5653.208550802891, 5665.5467562594895, 5667.546596272288, 5683.0338842396895, 5685.090385538294, 4957.3307603473795, 5019.422766381913, 5030.698158110452, 5036.0, 5106.923396148986, 6052.303985041688, 6053.636781793019, 6054.757809687563, 6066.454019138387, 6067.848303792352, 5833.883322333614, 5841.532677385714, 5843.386444423274, 5851.795187168429, 5857.121431785266, 6014.0377539593455, 6116.822755456359, 6136.856084434072, 6142.201513803177, 6230.221222347207, 5900.232969713909, 5912.349641539513, 5919.082542205965, 5920.437558431942, 5921.822345329647, 5964.373740757158, 6001.789937352171, 6010.939890601038, 6020.217371741645, 6024.728887199999, 5649.943500564942, 5671.801486947937, 5672.404397538364, 5725.484706376279, 5906.527477801851, 5700.686462244616, 5710.857228569319, 5712.6286791358425, 5722.284714410699, 5741.885162296647, 5609.102543593006, 5658.434156584309, 5658.490735833795, 5669.489745922887, 5669.631473954345, 5682.6306290091015, 5718.628289161191, 5736.368999410145, 5807.216025836458, 5826.155207494974, 5697.430256974435, 5702.800401985911, 5708.80019199326, 5727.11229759388, 5729.054705973468], "value": 5486.832738976372, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.4467528185863, 629.8834715577618, 638.7253481003169, 640.0015975078875, 666.1839246922519, 46514.76742616286, 48636.75681621587, 48726.51273487264, 48745.51254487454, 52842.0, 49878.50121498784, 50337.0, 50369.74815125919, 50386.0, 50386.74033149173, 8948.463092214455, 9421.5396613525, 9518.428894266332, 9577.473238971854, 9579.473128977903, 11152.832707509393, 11491.253068550559, 11499.0, 11866.821997670042, 11871.0, 11632.941835290812, 11673.474693638807, 11691.298522088659, 11699.23954942926, 11708.180427370087, 11427.0, 11464.885351146466, 11465.31208127515, 11476.254043487146, 11482.942585287105, 11233.831492527537, 11276.887231127666, 11324.094072474183, 11341.092712582973, 11341.319520828776, 46710.532894670956, 47038.52961470376, 47065.76467117677, 47114.87983040771, 47138.5286147141, 3818.751781134245, 3857.286402015608, 3871.457995880579, 4009.939850902239, 4164.250434921712, 35314.58741650331, 35460.46809297863, 35512.112197195274, 35557.0, 35716.82141589275, 4785.760711964388, 4855.417349917997, 4904.828331008433, 4911.950880491185, 4963.726995015273, 386576.0, 389330.0, 389482.0, 390740.0, 392592.03703981586, 66046.0, 66710.99933501001, 66765.33234667688, 66765.66617166882, 66864.0, 39987.80006099951, 41350.79324603358, 41363.37954930678, 43248.0, 43316.0, 17257.0, 17426.39007634752, 17459.301627934994, 17498.650026999643, 17515.299388024338, 10515.263931524873, 12137.332446715338, 12219.327936963375, 12797.360131993362, 13134.474621015244, 21075.0, 21337.78662213389, 21378.893105534684, 21386.144554217968, 21451.67822482664, 7438.012400018038, 7629.8855517167285, 7745.0, 7757.866586688706, 7807.141214466405, 1049.37037777333, 1076.364944682641, 1140.0651465797966, 1153.7865494883306, 1189.6252680405644, 35004.47493287603, 35010.64989350074, 35194.29611407809, 35227.64772352295, 35775.105622359646, 1093.868735751715, 1152.9596464123715, 1198.6463993121877, 1224.400043978462, 1277.8530468995998, 18461.261549538136, 18593.814061859477, 18794.248230070916, 18819.623607527774, 19043.238270469305, 602418.0, 606066.0, 606078.0, 606185.0, 613513.0, 68305.3169468299, 68694.65652671705, 68755.0, 68858.65570672114, 68883.0, 1333.513267657298, 1388.6042477893752, 1417.4401111561083, 1425.4796999095463, 1449.7970284160226, 34581.0, 36916.63083369239, 36943.81528092342, 37072.81463592772, 37139.0, 55757.721211393684, 56234.71882640724, 56772.148417774595, 56856.0, 57032.42967570271, 438955.0, 441544.0, 441728.0, 443522.0, 443952.0, 31237.531437028916, 32507.34985300328, 32611.673883260864, 32778.18054548655, 33932.62471626962, 54103.0, 54255.45744542504, 54847.177292339846, 55109.0, 55629.72185139048, 45463.0, 46044.53955460402, 46061.30908036449, 46886.0, 48125.0, 45898.311525327816, 46326.76836615795, 46408.0, 47087.0, 47518.52481475141, 44981.55018449773, 45007.54992450165, 45906.54093459023, 46433.30350044685, 46644.53355466537, 36977.63022369849, 40122.79938600288, 41082.383764242964, 41308.79345603253, 41478.1704365917, 30432.695673043872, 30539.0, 30889.69110308868, 30950.0, 31055.53416698706], "value": 22258.876234997242, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.2391646081293, 415.814962341758, 426.79300539238466, 430.98707038788837, 438.07784613388816, 15276.694466110672, 20665.793342066576, 20868.269610563635, 21409.46476338092, 21624.567508649816, 20431.795682043175, 20536.691949620767, 20545.0, 20564.38306850797, 20827.895860520715, 5854.795082172125, 5914.408559144094, 5950.642961422329, 5966.403359664042, 6000.969995150018, 5956.7319470623925, 5998.790042348519, 6000.3699611540815, 6003.249593800775, 6003.849903752419, 5703.31560212775, 5914.2311499505, 5938.613990090652, 5999.790007349744, 6019.097135429677, 5961.761529538813, 5992.9700351498395, 6003.519718422537, 6041.486473649745, 6110.3889611038985, 6010.338862725097, 6070.514358851281, 6070.757169713206, 6072.9696351518405, 6080.118382834508, 14295.213763243017, 14535.345909434101, 14744.631384215374, 14835.777463338058, 14850.108993460426, 2392.760723927611, 2480.2807185916063, 2961.3781105967773, 3084.306031142997, 3104.301532155247, 10287.89712102877, 10964.506597203144, 11018.669439916735, 11066.446438876794, 11403.0, 1949.278766856258, 1961.7940116287728, 1965.1451618545977, 1979.297349440942, 2092.665173572236, 81345.59327203385, 90582.0, 90963.09036909613, 91301.0, 93657.0, 10859.0, 11102.834947185222, 11192.328460292409, 11457.369844658624, 11710.180287379802, 16710.331586736393, 16712.665746684997, 16724.49826505207, 16755.162241887858, 16756.0, 8192.918070819216, 8282.58587070644, 8343.916560834436, 8455.661773529113, 8654.394192406471, 7823.726169584037, 7881.724139655199, 8025.879611805827, 8262.256396924306, 8287.709930152536, 4947.876303092451, 4956.430010548833, 4958.479359667255, 5093.668911520739, 5149.029885698884, 2035.9389218323474, 2069.244725675118, 2093.8588469284277, 2108.7258656374574, 2127.159771890095, 862.4480332587149, 947.1333729637443, 948.9845864924603, 961.423146112327, 985.6402413119304, 18584.491093702178, 19384.224631014884, 19923.302684405975, 20070.297539586336, 20099.59800804005, 951.7763325618474, 957.5882370580578, 959.6545243712258, 975.4196253229317, 988.5304480371766, 10492.737681558023, 10968.506417211245, 10972.725681858017, 11063.336199828036, 11105.222634415675, 466356.0, 469021.0, 538602.0, 559785.0, 562069.0, 60134.69932650309, 61615.691921541, 85735.57132214424, 98011.50994244983, 98639.50680246696, 986.4426598971702, 1000.6647772995982, 1007.2194049611463, 1017.7913527726798, 1045.1847558904067, 17095.91452042732, 17170.055646939538, 17571.912140439217, 17927.551811204823, 17983.190756416254, 43232.78383608062, 44224.0, 44931.55068449405, 45199.548004519536, 46541.0, 62483.0, 63190.684046579474, 63196.368036320884, 63373.683131584046, 63543.0, 8931.553422328727, 9158.084191581054, 9170.0, 9231.907680923105, 9241.491717955578, 11069.335839849635, 13638.727225455634, 13775.793363099361, 13838.515651952133, 14268.0, 11409.144314176305, 11960.521579136737, 12102.394880256128, 12134.271943683407, 12330.198537095419, 11654.184207105422, 11728.530858765555, 11779.175457717878, 12240.081993850676, 12308.753824923631, 8623.956880215559, 11292.717682058013, 11586.88413115858, 11747.001504872182, 11841.28952262867, 12938.159019663692, 13625.93187034098, 13897.374618142007, 13981.790273145707, 14043.297835108408, 12886.09797314179, 12898.161619494704, 12975.416106275052, 12993.480260789462, 13525.72948541004], "value": 9565.472442344077, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1393.4704812171374, 1519.5289460267318, 1539.622792415858, 1714.6827836850184, 1867.281096777741, 8479.576021198938, 8838.0, 8866.290696744269, 9127.68053118141, 9130.04134565871, 8920.732378028653, 9072.63709451621, 9073.909260907405, 9074.773130671736, 9075.36472446929, 2456.0912462388897, 2473.6907886514186, 2481.2060140754966, 2481.553320402327, 2487.6268559716004, 2415.867127307997, 2513.183215454975, 2513.258588716333, 2513.7988960883176, 2515.0694243129974, 2416.7462416446283, 2455.3861534616344, 2500.0749722602573, 2501.3496490912403, 2501.3621526510715, 2277.0664027748708, 2304.5506126305377, 2307.238611258289, 2347.518758654489, 2351.071326825894, 2410.2166795791436, 2426.2721183644835, 2449.865257410842, 2452.227548322273, 2456.0, 8972.237359824423, 9089.954550227207, 9103.226225770752, 9104.544772761335, 9116.361854670176, 5608.915866262009, 5849.502792262663, 5867.618604790675, 5870.706464676792, 5880.529557635379, 3563.2695297463956, 3579.011525376314, 3590.4434812604086, 3654.031681604377, 3656.981715091434, 1195.8863907928733, 1206.215959626241, 1212.9636110916686, 1225.497546006142, 1244.3591550351575, 13292.335383230897, 13362.465501379933, 13449.529266475627, 13452.260125693083, 13470.865291347158, 4771.976140119346, 4794.664373493822, 4823.0, 4892.902141957141, 4983.90032199354, 10556.577736890438, 10632.255742098134, 10642.574297028186, 10657.467126643636, 10662.200334974908, 5725.026745453283, 5733.082706766897, 5735.0, 5735.397783232784, 5742.052561327334, 4669.929951050737, 4811.711297322172, 5148.742562871841, 5198.870028249248, 5299.099153143975, 4211.663066954637, 4256.2551553478015, 4295.634871035997, 4308.612224899774, 4332.176886391576, 1256.7612153690952, 1272.3638180909545, 1284.6575328781446, 1284.7366289910547, 1289.8323217981601, 932.2495391210006, 1006.3307900246255, 1025.7486915705551, 1038.4963292802984, 1057.836035414512, 6280.403361680633, 6312.147860038836, 6329.651869147149, 6338.080978258126, 6652.667366631649, 480.8485327121945, 482.445188033764, 491.94096708394505, 498.9700617962934, 500.72460146919775, 4400.9559904401185, 4421.204183246982, 4425.3140763181755, 4467.503386365604, 4476.127155204704, 11045.889541104647, 11380.715482113013, 11666.76666466683, 11785.528578856922, 11791.0, 11275.210735248455, 11464.828027579593, 11517.308961462339, 11532.36571988532, 11559.36423496699, 8521.275691566163, 8657.783555411164, 8660.35047371437, 8669.393142480092, 8701.912980870236, 6595.0, 6715.529912906245, 6740.427063699641, 6825.89761153593, 6853.9314606853295, 10579.725359047534, 10816.459177040959, 10870.0, 10871.728206794576, 10900.618478353219, 9088.591013404544, 10620.628278010232, 10743.086837618577, 10809.729756756144, 10948.0, 8355.958220209102, 8500.617472213642, 8565.828683426173, 8567.957160214159, 8572.657093716181, 9028.81942361136, 9034.638614455349, 9067.591958361758, 9074.228690561113, 9096.681616143404, 7882.487638303492, 7927.881081783663, 8020.358371330396, 8211.917880821115, 8305.0, 7693.538387696756, 7854.607269636381, 7967.840643186988, 8018.158093400342, 8048.718294859652, 7399.556026638419, 7454.0, 7503.399728021636, 7506.13679426851, 7520.548767073993, 5539.975104605661, 5540.972295138498, 5623.493885550321, 5642.125470552071, 5699.316082070012, 5332.893342133058, 5336.466353364633, 5402.540784033401, 5470.507654311131, 5620.915686264628], "value": 4820.185945634321, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.5839950458954, 351.0609120602388, 351.9190586165181, 353.55805243445695, 357.8300307354009, 5493.423190564993, 5503.972480137599, 5565.638233514819, 5574.358948720898, 5575.470330318613, 5445.128779395298, 5449.863753406167, 5483.506484416402, 5495.258140151079, 5496.148097044955, 3855.595162507924, 4104.6921480888905, 4301.827926882921, 4318.460192475941, 4327.935080973788, 4309.427059123413, 4311.741295522263, 4325.351197320396, 4332.913341733163, 4341.110072435159, 4254.4043833863125, 4305.806238719265, 4317.935230971538, 4324.654027677794, 4355.281378572532, 4155.896102597429, 4221.894452638693, 4310.568943105695, 4337.587929146726, 4354.107407981356, 3813.8474461021524, 3822.1591249924973, 3833.3291673957224, 3836.0, 3871.606221760164, 5259.86850328741, 5296.040465027926, 5338.412774594792, 5346.770242844168, 5359.892802143974, 4854.587360074363, 4926.482719314492, 4927.039227350668, 4935.605151587864, 4999.600031997432, 5647.8588035299035, 5648.43515648436, 5649.8587535311535, 5651.0, 5663.886722265532, 4201.390798334255, 4201.432806571104, 4208.200441916026, 4240.279152544075, 4245.830166793325, 5652.830415087554, 5752.884942301131, 5796.507296879812, 5891.823245302648, 5897.469227769521, 4265.0, 4277.871663850089, 4297.806598703003, 4299.78501074945, 4312.633426158812, 4364.454443194601, 4365.301551751768, 4367.825286988548, 4368.301071828492, 4383.473983122046, 4806.327114204014, 4888.584470319992, 4917.58200552957, 4921.0, 4939.5554400104165, 5719.57103217252, 5725.799597014085, 5732.914006289909, 5739.311282646109, 5760.8271751847515, 1497.8427265137223, 1516.150955464943, 1518.9240537973058, 1519.384649217069, 1522.7944227529363, 937.5218638494417, 971.5433746139303, 979.1383582447543, 990.3810118675827, 991.7718924647227, 4872.930054065987, 4876.512348765095, 4887.266909963534, 4900.480850936221, 4938.580220681282, 5084.068054139403, 5093.752030752489, 5104.3874735031295, 5151.042603810603, 5164.147915593885, 4605.585497305258, 4871.29366241893, 4897.2898929655, 4929.75351232437, 4935.629827762932, 2732.5901114832536, 2734.371094648242, 2749.0344403751415, 2761.792865535053, 2775.639936431134, 5268.315119034501, 5309.619498930306, 5330.840074797762, 5361.597880159004, 5362.302900622894, 5136.383633963948, 5156.819511317086, 5597.972010139923, 6081.209442772411, 6087.543434242361, 6196.132541444202, 6199.690015499207, 6202.131701561785, 6206.596571222856, 6216.813495595049, 5916.290045194604, 5923.49650279731, 5992.43071908168, 6063.484128967758, 6077.574569780073, 5854.619449735754, 5866.354700982974, 5907.556933229939, 5917.3490915998345, 5925.733341999534, 5901.675407852437, 6005.219321488178, 6009.87980240384, 6022.0, 6135.159452164244, 3982.1637456133376, 4158.0, 4194.098268872207, 4199.496060472763, 4215.662746980295, 5879.118132280021, 5911.793087241926, 5917.112433135064, 5927.881442371215, 5944.851378715393, 5712.457956209447, 5824.204381896629, 5837.67892765902, 5864.530837532901, 5872.383399742966, 5652.293463317085, 5668.404817494269, 5721.828345149652, 5773.653580785166, 5783.913241301299, 5689.7439615218245, 5705.34388545306, 5706.115552089433, 5709.942900570941, 5794.971025144847, 5709.486146246858, 5712.742926568231, 5779.566532510163, 5797.188393624981, 5878.647281163144, 5662.518685911744, 5663.490285874291, 5669.829905102853, 5675.318961724454, 5738.512226460798], "value": 4324.318337310425, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [781.6091954022988, 798.4610387988107, 806.7337778533084, 828.2256090555331, 842.2714352085446, 16149.919250403746, 16820.831791682078, 17346.392876249334, 17619.823801761977, 17869.7319540207, 16461.83538164618, 16471.258793354296, 16545.0, 16637.584060398494, 16728.330866765344, 739.0872272743185, 855.3798496090347, 875.4572165257549, 876.3120950054209, 886.3751055505853, 875.4090988582712, 883.4699180491718, 883.765802062454, 883.8011447424342, 883.9116088391141, 924.1636319131197, 934.2105920497169, 934.2992755433424, 934.313279739391, 934.9672761453351, 760.4334770595914, 906.2387594420652, 931.2782593490032, 931.483026920059, 934.0939288889766, 683.8290427393151, 683.8392977650249, 684.1755684400335, 684.336193891929, 685.4276678973064, 15552.222388880511, 15572.221388930508, 15603.765943510856, 15607.45373911919, 15638.530844074696, 14809.481668141563, 14968.47610333644, 14973.850261497355, 15014.24928753569, 15035.924820375938, 13251.536196233183, 13308.0, 13376.130551514121, 13510.797338039938, 13725.794113088312, 4499.280115181556, 4577.748223847687, 4578.545393149087, 4592.2193227151465, 4659.301104834268, 85712.57143714304, 86704.56647716784, 87912.0, 88070.559647202, 90675.09324906733, 11101.5559377624, 11271.0, 11273.492692828842, 11334.206605537698, 11437.199396042197, 21625.35123946284, 21643.67534486984, 21661.0, 21676.45808854791, 21772.56454870894, 8483.151684831468, 8716.564171791386, 8795.296376289882, 8800.251978581764, 9193.034731353246, 4970.8757281068265, 4988.152014157602, 5023.120953833065, 5123.2827404163445, 5132.871678208075, 3607.3687104756564, 3716.9070773230887, 3720.069982504374, 3725.720570957189, 3742.3825068863875, 653.9705713242915, 658.4271683635172, 664.51158398577, 666.4401902401909, 670.0184230102923, 661.1999480628398, 708.914930208368, 709.2517394149222, 734.3757805865079, 737.0087232672048, 9169.40398874071, 9682.322237443312, 9801.0, 9833.60665573369, 10179.338343007681, 612.4059662127729, 650.3593959949446, 694.9548279361825, 711.6299524247362, 773.1263672050546, 4586.816527338936, 4608.9308660370125, 4611.792469338888, 4616.238320677051, 4657.976710116428, 127742.0, 133254.0, 135989.0, 138446.0, 139090.30454847662, 108893.45553272341, 110649.0, 112921.0, 116162.41918790352, 119208.0, 100954.0, 104970.4751476253, 105203.0, 105789.0, 106709.0, 9125.361224714206, 9132.49771262587, 9172.495512746864, 9187.0, 9247.815043699224, 58098.7095064522, 58785.70607146937, 60122.0, 61275.08087378782, 62571.0, 84136.0, 91293.54353228191, 91806.0, 93492.0, 95226.0, 11859.110566707359, 11934.343611101125, 11968.880311196777, 12583.370831458207, 12720.6819829505, 12303.507859685513, 12700.936495317465, 12969.027322950627, 13248.602541923758, 13383.19700817954, 12491.875081249435, 12742.426590803621, 13305.534306299232, 13472.056956012984, 13713.657158571115, 12297.815532767194, 12595.93702031484, 12705.237685738884, 13157.276349800853, 13284.933575332061, 11600.6519804406, 11622.82565761531, 11696.766064678828, 11758.58844940423, 12031.15781895259, 10675.839862402225, 10832.079273261861, 10906.672799816019, 10919.945400272947, 11064.889351106385, 10474.319169253975, 10569.639782217218, 10800.513976870903, 10800.783984320427, 10929.0], "value": 7908.7961842373825, "unit": "score"}], "name": "dromaeo_css", "value": 7599.382475896956, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 118.0, 111.0, 114.0, 110.0, 110.0, 109.0, 110.0, 112.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 115.0, 139.0, 165.0, 119.0, 150.0, 138.0, 119.0, 175.0, 115.0], "value": 137.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 160.0, 159.0, 161.0, 161.0, 162.0, 160.0, 160.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 180.0, 76.0, 75.0, 74.0, 76.0, 156.0, 76.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 160.0, 84.0, 84.0, 84.0, 139.0, 83.0, 83.0, 147.0], "value": 103.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 116.0, 116.0, 117.0, 116.0, 116.0, 117.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 97.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 54.0, 50.0, 51.0, 51.0, 51.0, 52.0, 51.0, 51.0, 51.0], "value": 51.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 66.0, 61.0, 61.0, 61.0, 65.0, 61.0, 61.0, 61.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 73.0, 76.0, 81.0, 72.0, 81.0, 75.0, 81.0, 72.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 116.0, 118.0, 117.0, 114.0, 118.0, 116.0, 120.0, 159.0, 121.0], "value": 122.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 158.0, 155.0, 153.0, 154.0, 152.0, 152.0, 161.0, 150.0, 152.0], "value": 154.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 61.0, 62.0, 64.0, 67.0, 64.0, 63.0, 62.0, 64.0, 62.0], "value": 63.3, "unit": "score"}], "name": "kraken", "value": 1492.3999999999999, "alertThreshold": 2.0}]} 04:01:17 INFO - Return code: 0 04:01:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:01:17 INFO - # TBPL SUCCESS # 04:01:17 INFO - Running post-action listener: _resource_record_post_action 04:01:17 INFO - [mozharness: 2016-09-16 11:01:17.097982Z] Finished run-tests step (success) 04:01:17 INFO - Running post-run listener: _resource_record_post_run 04:01:17 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 270336; Write bytes: 328138752; Read time: 184; Write time: 226232 04:01:17 INFO - TinderboxPrint: CPU usage
12.9% 04:01:17 INFO - TinderboxPrint: I/O read bytes / time
270,336 / 184 04:01:17 INFO - TinderboxPrint: I/O write bytes / time
328,138,752 / 226,232 04:01:17 INFO - TinderboxPrint: CPU idle
8,268.4 (87.0%) 04:01:17 INFO - TinderboxPrint: CPU user
1,184.9 (12.5%) 04:01:17 INFO - TinderboxPrint: Swap in / out
0 / 0 04:01:17 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 77160448; Read time: 24; Write time: 71640 04:01:17 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 266240; Write bytes: 248627200; Read time: 160; Write time: 154388 04:01:17 INFO - Running post-run listener: _upload_blobber_files 04:01:17 INFO - Blob upload gear active. 04:01:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:01:17 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 04:01:17 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:01:17 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:01:18 INFO - (blobuploader) - INFO - Open directory for files ... 04:01:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:01:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:01:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:01:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:01:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:01:19 INFO - (blobuploader) - INFO - Done attempting. 04:01:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:01:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:01:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:01:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:01:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:01:23 INFO - (blobuploader) - INFO - Done attempting. 04:01:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:01:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:01:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:01:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:01:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:01:23 INFO - (blobuploader) - INFO - Done attempting. 04:01:23 INFO - (blobuploader) - INFO - Iteration through files over. 04:01:23 INFO - Return code: 0 04:01:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:01:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:01:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2bb85661cf846b52978d20f50d69e43096abf67dd30298bf5b3ea7a083fd7d97a8a9f842745b54d76fb98acf17c53f8baa324fe5fdb464e678160fccd114ecf2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c9d707859972afa9e97e0feb62fb7c44f22929b7080ea5f2bf62ce5263fb6f7aa371fd0740fb866a76d77ba8fe37325aa7a35d07f71ebc472297104af656f137", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/309d6ed5a325b293372865a7fc257aa98b2fe4fb2dbc746f2601477b69f7a18a0cccfd323f1b3411a0e99b3a20830ce74cbc42b2333cb48914ef3963b89a8df0"} 04:01:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:01:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:01:23 INFO - Contents: 04:01:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2bb85661cf846b52978d20f50d69e43096abf67dd30298bf5b3ea7a083fd7d97a8a9f842745b54d76fb98acf17c53f8baa324fe5fdb464e678160fccd114ecf2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c9d707859972afa9e97e0feb62fb7c44f22929b7080ea5f2bf62ce5263fb6f7aa371fd0740fb866a76d77ba8fe37325aa7a35d07f71ebc472297104af656f137", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/309d6ed5a325b293372865a7fc257aa98b2fe4fb2dbc746f2601477b69f7a18a0cccfd323f1b3411a0e99b3a20830ce74cbc42b2333cb48914ef3963b89a8df0"} 04:01:23 INFO - Running post-run listener: copy_logs_to_upload_dir 04:01:23 INFO - Copying logs to upload dir... 04:01:23 INFO - mkdir: /builds/slave/test/build/upload/logs 04:01:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1677.871118 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 57 secs) (at 2016-09-16 04:01:23.698525) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-16 04:01:23.702157) ========= 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=4300f881736b422476174874000001bc-1474022003.178916-1333656674 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2bb85661cf846b52978d20f50d69e43096abf67dd30298bf5b3ea7a083fd7d97a8a9f842745b54d76fb98acf17c53f8baa324fe5fdb464e678160fccd114ecf2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c9d707859972afa9e97e0feb62fb7c44f22929b7080ea5f2bf62ce5263fb6f7aa371fd0740fb866a76d77ba8fe37325aa7a35d07f71ebc472297104af656f137", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/309d6ed5a325b293372865a7fc257aa98b2fe4fb2dbc746f2601477b69f7a18a0cccfd323f1b3411a0e99b3a20830ce74cbc42b2333cb48914ef3963b89a8df0"} build_url:https://queue.taskcluster.net/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011512 build_url: 'https://queue.taskcluster.net/v1/task/J6Nn15oSRR-8M-hude6_zA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2bb85661cf846b52978d20f50d69e43096abf67dd30298bf5b3ea7a083fd7d97a8a9f842745b54d76fb98acf17c53f8baa324fe5fdb464e678160fccd114ecf2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c9d707859972afa9e97e0feb62fb7c44f22929b7080ea5f2bf62ce5263fb6f7aa371fd0740fb866a76d77ba8fe37325aa7a35d07f71ebc472297104af656f137", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/309d6ed5a325b293372865a7fc257aa98b2fe4fb2dbc746f2601477b69f7a18a0cccfd323f1b3411a0e99b3a20830ce74cbc42b2333cb48914ef3963b89a8df0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-16 04:01:23.733534) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-16 04:01:23.733897) ========= 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=4300f881736b422476174874000001bc-1474022003.178916-1333656674 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004424 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-16 04:01:23.818395) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-16 04:01:23.818799) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-16 04:01:23.819153) ========= ========= Total master_lag: 0.18 =========