builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-017 starttime: 1468342163.33 results: success (0) buildid: 20160712071125 builduid: 9d5121683529498f8824e102bdd8d305 revision: 50dfed915c24291922414771d3622c336d28b87e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 09:49:23.332285) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 09:49:23.332847) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 09:49:23.333211) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 09:49:23.349631) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 09:49:23.350322) ========= 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=0333a256a5e4f052382dd180000001b1-1468342162.464043-1874228474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-12 09:49:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.9M=0s 2016-07-12 09:49:23 (46.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103285 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 09:49:23.468153) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 09:49:23.468552) ========= 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=0333a256a5e4f052382dd180000001b1-1468342162.464043-1874228474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020586 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 09:49:23.518118) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 09:49:23.518500) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 50dfed915c24291922414771d3622c336d28b87e --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 50dfed915c24291922414771d3622c336d28b87e --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=0333a256a5e4f052382dd180000001b1-1468342162.464043-1874228474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-12 09:49:23,774 truncating revision to first 12 chars 2016-07-12 09:49:23,774 Setting DEBUG logging. 2016-07-12 09:49:23,774 attempt 1/10 2016-07-12 09:49:23,774 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/50dfed915c24?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 09:49:24,081 unpacking tar archive at: mozilla-aurora-50dfed915c24/testing/mozharness/ program finished with exit code 0 elapsedTime=0.650567 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 09:49:24.183502) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 09:49:24.183895) ========= script_repo_revision: 50dfed915c24291922414771d3622c336d28b87e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 09:49:24.184382) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 09:49:24.184723) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 09:49:24.195366) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-12 09:49:24.195708) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=0333a256a5e4f052382dd180000001b1-1468342162.464043-1874228474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:49:24 INFO - MultiFileLogger online at 20160712 09:49:24 in /builds/slave/test 09:49:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:49:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:49:24 INFO - {'append_to_log': False, 09:49:24 INFO - 'base_work_dir': '/builds/slave/test', 09:49:24 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:49:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:49:24 INFO - 'branch': 'Mozilla-Aurora', 09:49:24 INFO - 'buildbot_json_path': 'buildprops.json', 09:49:24 INFO - 'config_files': ('talos/linux_config.py',), 09:49:24 INFO - 'default_actions': ('clobber', 09:49:24 INFO - 'read-buildbot-config', 09:49:24 INFO - 'download-and-extract', 09:49:24 INFO - 'populate-webroot', 09:49:24 INFO - 'create-virtualenv', 09:49:24 INFO - 'install', 09:49:24 INFO - 'run-tests'), 09:49:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:49:24 INFO - 'download_minidump_stackwalk': True, 09:49:24 INFO - 'download_symbols': 'ondemand', 09:49:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:49:24 INFO - 'tooltool.py': '/tools/tooltool.py', 09:49:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:49:24 INFO - '/tools/misc-python/virtualenv.py')}, 09:49:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:49:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:49:24 INFO - 'installer_path': 'installer.exe', 09:49:24 INFO - 'log_level': 'info', 09:49:24 INFO - 'log_name': 'talos', 09:49:24 INFO - 'log_to_console': True, 09:49:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:49:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:49:24 INFO - 'opt_config_files': (), 09:49:24 INFO - 'pip_index': False, 09:49:24 INFO - 'sps_profile': False, 09:49:24 INFO - 'sps_profile_interval': 0, 09:49:24 INFO - 'suite': 'dromaeojs-e10s', 09:49:24 INFO - 'system_bits': '32', 09:49:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:49:24 INFO - 'title': 'talos-linux64-ix-017', 09:49:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:49:24 INFO - 'use_talos_json': True, 09:49:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:49:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:49:24 INFO - 'work_dir': 'build'} 09:49:24 INFO - ##### 09:49:24 INFO - ##### Running clobber step. 09:49:24 INFO - ##### 09:49:24 INFO - Running pre-action listener: _resource_record_pre_action 09:49:24 INFO - Running main action method: clobber 09:49:24 INFO - rmtree: /builds/slave/test/build 09:49:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:49:25 INFO - Running post-action listener: _resource_record_post_action 09:49:25 INFO - ##### 09:49:25 INFO - ##### Finished clobber step (success) 09:49:25 INFO - ##### 09:49:25 INFO - ##### 09:49:25 INFO - ##### Running read-buildbot-config step. 09:49:25 INFO - ##### 09:49:25 INFO - Running pre-action listener: _resource_record_pre_action 09:49:25 INFO - Running main action method: read_buildbot_config 09:49:25 INFO - Using buildbot properties: 09:49:25 INFO - { 09:49:25 INFO - "project": "", 09:49:25 INFO - "product": "firefox", 09:49:25 INFO - "script_repo_revision": "production", 09:49:25 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 09:49:25 INFO - "repository": "", 09:49:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 09:49:25 INFO - "buildid": "20160712071125", 09:49:25 INFO - "pgo_build": "True", 09:49:25 INFO - "basedir": "/builds/slave/test", 09:49:25 INFO - "buildnumber": 440, 09:49:25 INFO - "slavename": "talos-linux64-ix-017", 09:49:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:49:25 INFO - "platform": "ubuntu64_hw", 09:49:25 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:49:25 INFO - "branch": "mozilla-aurora", 09:49:25 INFO - "repo_path": "releases/mozilla-aurora", 09:49:25 INFO - "revision": "50dfed915c24291922414771d3622c336d28b87e", 09:49:25 INFO - "stage_platform": "linux64-pgo", 09:49:25 INFO - "builduid": "9d5121683529498f8824e102bdd8d305", 09:49:25 INFO - "slavebuilddir": "test" 09:49:25 INFO - } 09:49:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 09:49:25 INFO - Running post-action listener: _resource_record_post_action 09:49:25 INFO - ##### 09:49:25 INFO - ##### Finished read-buildbot-config step (success) 09:49:25 INFO - ##### 09:49:25 INFO - ##### 09:49:25 INFO - ##### Running download-and-extract step. 09:49:25 INFO - ##### 09:49:25 INFO - Running pre-action listener: _resource_record_pre_action 09:49:25 INFO - Running main action method: download_and_extract 09:49:25 INFO - mkdir: /builds/slave/test/build/tests 09:49:25 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')]} 09:49:25 INFO - https://queue.taskcluster.net/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:49:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 09:49:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 09:49:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 09:49:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:49:26 INFO - Downloaded 1361 bytes. 09:49:26 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 09:49:26 INFO - Using the following test package requirements: 09:49:26 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 09:49:26 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:49:26 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:49:26 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:49:26 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:49:26 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:49:26 INFO - u'jsshell-linux-x86_64.zip'], 09:49:26 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:49:26 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:49:26 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 09:49:26 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:49:26 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:49:26 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:49:26 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:49:26 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:49:26 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:49:26 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:49:26 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:49:26 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:49: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')]} 09:49:26 INFO - https://queue.taskcluster.net/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:49:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 09:49:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 09:49:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 09:49:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:49:27 INFO - Downloaded 24527633 bytes. 09:49:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:49:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:49:28 INFO - Return code: 0 09:49:28 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:49:28 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')]} 09:49:28 INFO - https://queue.taskcluster.net/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:49:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 09:49:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 09:49:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 09:49:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:49:29 INFO - Downloaded 24527633 bytes. 09:49:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:49:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:49:31 INFO - Return code: 0 09:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:49:31 INFO - https://queue.taskcluster.net/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:49:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 09:49:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 09:49:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 09:49:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:49:32 INFO - Downloaded 10833369 bytes. 09:49:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:49:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:49:32 INFO - Return code: 0 09:49: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')]} 09:49:32 INFO - https://queue.taskcluster.net/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:49:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 09:49:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 09:49:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 09:49:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:49:34 INFO - Downloaded 63639154 bytes. 09:49:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 09:49:34 INFO - mkdir: /builds/slave/test/properties 09:49:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:49:34 INFO - Writing to file /builds/slave/test/properties/build_url 09:49:34 INFO - Contents: 09:49:34 INFO - build_url:https://queue.taskcluster.net/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 09:49:34 INFO - Running post-action listener: _resource_record_post_action 09:49:34 INFO - Running post-action listener: set_extra_try_arguments 09:49:34 INFO - ##### 09:49:34 INFO - ##### Finished download-and-extract step (success) 09:49:34 INFO - ##### 09:49:34 INFO - ##### 09:49:34 INFO - ##### Running populate-webroot step. 09:49:34 INFO - ##### 09:49:34 INFO - Running pre-action listener: _resource_record_pre_action 09:49:34 INFO - Running main action method: populate_webroot 09:49:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:49:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:49:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:49:34 INFO - '--tppagecycles', 09:49:34 INFO - '7'], 09:49:34 INFO - 'tests': ['tsvgm']}}, 09:49:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:49:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:49:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:49:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:49:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:49:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:49:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:34 INFO - 'talos_options': ['--disable-e10s'], 09:49:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:49:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:49:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:34 INFO - 'talos_options': ['--disable-e10s'], 09:49:34 INFO - 'tests': ['damp', 'tps']}, 09:49:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:34 INFO - 'tests': ['damp', 'tps']}, 09:49:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:49:34 INFO - 'tests': ['dromaeo_dom']}, 09:49:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:49:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:49:34 INFO - 'tests': ['a11yr', 09:49:34 INFO - 'ts_paint', 09:49:34 INFO - 'tpaint', 09:49:34 INFO - 'sessionrestore', 09:49:34 INFO - 'sessionrestore_no_auto_restore', 09:49:34 INFO - 'tabpaint']}, 09:49:34 INFO - 'other-e10s': {'tests': ['a11yr', 09:49:34 INFO - 'ts_paint', 09:49:34 INFO - 'tpaint', 09:49:34 INFO - 'sessionrestore', 09:49:34 INFO - 'sessionrestore_no_auto_restore', 09:49:34 INFO - 'tabpaint']}, 09:49:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:49:34 INFO - 'ts_paint', 09:49:34 INFO - 'tpaint', 09:49:34 INFO - 'sessionrestore', 09:49:34 INFO - 'sessionrestore_no_auto_restore', 09:49:34 INFO - 'tabpaint']}, 09:49:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:49:34 INFO - 'ts_paint', 09:49:34 INFO - 'tpaint', 09:49:34 INFO - 'sessionrestore', 09:49:34 INFO - 'sessionrestore_no_auto_restore', 09:49:34 INFO - 'tabpaint']}, 09:49:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:49:34 INFO - 'tests': ['a11yr', 09:49:34 INFO - 'ts_paint', 09:49:34 INFO - 'tpaint', 09:49:34 INFO - 'sessionrestore', 09:49:34 INFO - 'sessionrestore_no_auto_restore', 09:49:34 INFO - 'tabpaint']}, 09:49:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:49:34 INFO - 'tests': ['a11yr', 09:49:34 INFO - 'ts_paint', 09:49:34 INFO - 'tpaint', 09:49:34 INFO - 'sessionrestore', 09:49:34 INFO - 'sessionrestore_no_auto_restore', 09:49:34 INFO - 'tabpaint']}, 09:49:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:49:34 INFO - 'tests': ['tsvgx', 09:49:34 INFO - 'tsvgr_opacity', 09:49:34 INFO - 'tart', 09:49:34 INFO - 'tscrollx', 09:49:34 INFO - 'cart']}, 09:49:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:49:34 INFO - 'tsvgr_opacity', 09:49:34 INFO - 'tart', 09:49:34 INFO - 'tscrollx', 09:49:34 INFO - 'cart']}, 09:49:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:34 INFO - 'talos_options': ['--disable-e10s'], 09:49:34 INFO - 'tests': ['tp5o']}, 09:49:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:34 INFO - 'tests': ['tp5o']}, 09:49:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:34 INFO - 'talos_options': ['--disable-e10s', 09:49:34 INFO - '--xperf_path', 09:49:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:49:34 INFO - 'tests': ['tp5n']}, 09:49:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:34 INFO - 'talos_options': ['--xperf_path', 09:49:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:49:34 INFO - 'tests': ['tp5n']}}, 09:49:34 INFO - 'talos.zip': {'path': '', 09:49:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:49:34 INFO - Running post-action listener: _resource_record_post_action 09:49:34 INFO - ##### 09:49:34 INFO - ##### Finished populate-webroot step (success) 09:49:34 INFO - ##### 09:49:34 INFO - ##### 09:49:34 INFO - ##### Running create-virtualenv step. 09:49:34 INFO - ##### 09:49:34 INFO - Running pre-action listener: _resource_record_pre_action 09:49:34 INFO - Running main action method: create_virtualenv 09:49:34 INFO - Creating virtualenv /builds/slave/test/build/venv 09:49:34 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 09:49:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:49:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:49:34 INFO - Using real prefix '/usr' 09:49:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:49:35 INFO - Installing distribute.............................................................................................................................................................................................done. 09:49:37 INFO - Installing pip.................done. 09:49:37 INFO - Return code: 0 09:49:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:49:37 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')]} 09:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:37 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')]} 09:49:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:37 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 0x7fb1c50bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1514350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a31c0>, '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 0x15a40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a4550>, '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': '0333a256a5e4f052382dd180000001b1-1468342162.464043-1874228474', '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 09:49:37 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 09:49:37 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 09:49:37 INFO - Using env: {'DISPLAY': ':0', 09:49:37 INFO - 'HOME': '/home/cltbld', 09:49:37 INFO - 'LANG': 'en_US.UTF-8', 09:49:37 INFO - 'LANGUAGE': 'en_US:en', 09:49:37 INFO - 'LOGNAME': 'cltbld', 09:49:37 INFO - 'MAIL': '/var/mail/cltbld', 09:49:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:37 INFO - 'MOZ_NO_REMOTE': '1', 09:49:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:37 INFO - 'NO_EM_RESTART': '1', 09:49:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:37 INFO - 'PWD': '/builds/slave/test', 09:49:37 INFO - 'SHELL': '/bin/bash', 09:49:37 INFO - 'SHLVL': '1', 09:49:37 INFO - 'TERM': 'linux', 09:49:37 INFO - 'TMOUT': '86400', 09:49:37 INFO - 'USER': 'cltbld', 09:49:37 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1468342162.464043-1874228474', 09:49:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:37 INFO - '_': '/tools/buildbot/bin/python'} 09:49:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:37 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 09:49:37 INFO - Cleaning up... 09:49:37 INFO - Return code: 0 09:49:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:49:37 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')]} 09:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:37 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')]} 09:49:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:37 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 0x7fb1c50bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1514350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a31c0>, '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 0x15a40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a4550>, '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': '0333a256a5e4f052382dd180000001b1-1468342162.464043-1874228474', '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 09:49:37 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 09:49:37 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 09:49:37 INFO - Using env: {'DISPLAY': ':0', 09:49:37 INFO - 'HOME': '/home/cltbld', 09:49:37 INFO - 'LANG': 'en_US.UTF-8', 09:49:37 INFO - 'LANGUAGE': 'en_US:en', 09:49:37 INFO - 'LOGNAME': 'cltbld', 09:49:37 INFO - 'MAIL': '/var/mail/cltbld', 09:49:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:37 INFO - 'MOZ_NO_REMOTE': '1', 09:49:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:37 INFO - 'NO_EM_RESTART': '1', 09:49:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:37 INFO - 'PWD': '/builds/slave/test', 09:49:37 INFO - 'SHELL': '/bin/bash', 09:49:37 INFO - 'SHLVL': '1', 09:49:37 INFO - 'TERM': 'linux', 09:49:37 INFO - 'TMOUT': '86400', 09:49:37 INFO - 'USER': 'cltbld', 09:49:37 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1468342162.464043-1874228474', 09:49:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:37 INFO - '_': '/tools/buildbot/bin/python'} 09:49:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:37 INFO - Downloading/unpacking psutil>=3.1.1 09:49:37 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 09:49:37 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 09:49:37 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 09:49:37 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 09:49:37 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 09:49:37 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 09:49:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:49:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:49:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:49:39 INFO - Installing collected packages: psutil 09:49:39 INFO - Running setup.py install for psutil 09:49:39 INFO - building 'psutil._psutil_linux' extension 09:49:39 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 09:49:40 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 09:49:40 INFO - building 'psutil._psutil_posix' extension 09:49:40 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 09:49:40 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 09:49:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:49:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:49:40 INFO - Successfully installed psutil 09:49:40 INFO - Cleaning up... 09:49:40 INFO - Return code: 0 09:49:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:49:40 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')]} 09:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:40 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')]} 09:49:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:40 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 0x7fb1c50bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1514350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a31c0>, '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 0x15a40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a4550>, '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': '0333a256a5e4f052382dd180000001b1-1468342162.464043-1874228474', '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 09:49:40 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 09:49:40 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 09:49:40 INFO - Using env: {'DISPLAY': ':0', 09:49:40 INFO - 'HOME': '/home/cltbld', 09:49:40 INFO - 'LANG': 'en_US.UTF-8', 09:49:40 INFO - 'LANGUAGE': 'en_US:en', 09:49:40 INFO - 'LOGNAME': 'cltbld', 09:49:40 INFO - 'MAIL': '/var/mail/cltbld', 09:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:40 INFO - 'MOZ_NO_REMOTE': '1', 09:49:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:40 INFO - 'NO_EM_RESTART': '1', 09:49:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:40 INFO - 'PWD': '/builds/slave/test', 09:49:40 INFO - 'SHELL': '/bin/bash', 09:49:40 INFO - 'SHLVL': '1', 09:49:40 INFO - 'TERM': 'linux', 09:49:40 INFO - 'TMOUT': '86400', 09:49:40 INFO - 'USER': 'cltbld', 09:49:40 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1468342162.464043-1874228474', 09:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:40 INFO - '_': '/tools/buildbot/bin/python'} 09:49:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:49:40 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 09:49:40 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 09:49:40 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 09:49:40 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 09:49:40 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 09:49:40 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 09:49:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:49:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:49:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:49:42 INFO - Installing collected packages: mozsystemmonitor 09:49:42 INFO - Running setup.py install for mozsystemmonitor 09:49:42 INFO - Successfully installed mozsystemmonitor 09:49:42 INFO - Cleaning up... 09:49:42 INFO - Return code: 0 09:49:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:49:42 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')]} 09:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:42 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')]} 09:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:42 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 0x7fb1c50bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1514350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a31c0>, '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 0x15a40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a4550>, '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': '0333a256a5e4f052382dd180000001b1-1468342162.464043-1874228474', '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 09:49:42 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 09:49:42 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 09:49:42 INFO - Using env: {'DISPLAY': ':0', 09:49:42 INFO - 'HOME': '/home/cltbld', 09:49:42 INFO - 'LANG': 'en_US.UTF-8', 09:49:42 INFO - 'LANGUAGE': 'en_US:en', 09:49:42 INFO - 'LOGNAME': 'cltbld', 09:49:42 INFO - 'MAIL': '/var/mail/cltbld', 09:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:42 INFO - 'MOZ_NO_REMOTE': '1', 09:49:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:42 INFO - 'NO_EM_RESTART': '1', 09:49:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:42 INFO - 'PWD': '/builds/slave/test', 09:49:42 INFO - 'SHELL': '/bin/bash', 09:49:42 INFO - 'SHLVL': '1', 09:49:42 INFO - 'TERM': 'linux', 09:49:42 INFO - 'TMOUT': '86400', 09:49:42 INFO - 'USER': 'cltbld', 09:49:42 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1468342162.464043-1874228474', 09:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:42 INFO - '_': '/tools/buildbot/bin/python'} 09:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:42 INFO - Downloading/unpacking jsonschema==2.5.1 09:49:42 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 09:49:42 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 09:49:42 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 09:49:42 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 09:49:42 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 09:49:42 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 09:49:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:49:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:49:44 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 09:49:44 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 09:49:44 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 09:49:44 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 09:49:44 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 09:49:44 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 09:49:45 INFO - Downloading functools32-3.2.3-2.tar.gz 09:49:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:49:45 INFO - warning: no files found matching '*.txt' 09:49:45 INFO - no previously-included directories found matching 'build' 09:49:45 INFO - no previously-included directories found matching 'dist' 09:49:45 INFO - no previously-included directories found matching '.git*' 09:49:45 INFO - Installing collected packages: jsonschema, functools32 09:49:45 INFO - Running setup.py install for functools32 09:49:45 INFO - warning: no files found matching '*.txt' 09:49:45 INFO - no previously-included directories found matching 'build' 09:49:45 INFO - no previously-included directories found matching 'dist' 09:49:45 INFO - no previously-included directories found matching '.git*' 09:49:45 INFO - Successfully installed jsonschema functools32 09:49:45 INFO - Cleaning up... 09:49:45 INFO - Return code: 0 09:49:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:49:45 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')]} 09:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:45 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')]} 09:49:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:45 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 0x7fb1c50bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1514350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a31c0>, '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 0x15a40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a4550>, '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': '0333a256a5e4f052382dd180000001b1-1468342162.464043-1874228474', '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 09:49:45 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 09:49:45 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 09:49:45 INFO - Using env: {'DISPLAY': ':0', 09:49:45 INFO - 'HOME': '/home/cltbld', 09:49:45 INFO - 'LANG': 'en_US.UTF-8', 09:49:45 INFO - 'LANGUAGE': 'en_US:en', 09:49:45 INFO - 'LOGNAME': 'cltbld', 09:49:45 INFO - 'MAIL': '/var/mail/cltbld', 09:49:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:45 INFO - 'MOZ_NO_REMOTE': '1', 09:49:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:45 INFO - 'NO_EM_RESTART': '1', 09:49:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:45 INFO - 'PWD': '/builds/slave/test', 09:49:45 INFO - 'SHELL': '/bin/bash', 09:49:45 INFO - 'SHLVL': '1', 09:49:45 INFO - 'TERM': 'linux', 09:49:45 INFO - 'TMOUT': '86400', 09:49:45 INFO - 'USER': 'cltbld', 09:49:45 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1468342162.464043-1874228474', 09:49:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:45 INFO - '_': '/tools/buildbot/bin/python'} 09:49:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:45 INFO - Downloading/unpacking blobuploader==1.2.4 09:49:45 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 09:49:45 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 09:49:45 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 09:49:45 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 09:49:45 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 09:49:45 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 09:49:47 INFO - Downloading blobuploader-1.2.4.tar.gz 09:49:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:49:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:49:47 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 09:49:47 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 09:49:47 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 09:49:47 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 09:49:47 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 09:49:47 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 09:49:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:49:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:49:47 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 09:49:47 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 09:49:47 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 09:49:47 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 09:49:47 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 09:49:47 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 09:49:48 INFO - Downloading docopt-0.6.1.tar.gz 09:49:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:49:48 INFO - Installing collected packages: blobuploader, requests, docopt 09:49:48 INFO - Running setup.py install for blobuploader 09:49:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:49:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:49:48 INFO - Running setup.py install for requests 09:49:48 INFO - Running setup.py install for docopt 09:49:48 INFO - Successfully installed blobuploader requests docopt 09:49:48 INFO - Cleaning up... 09:49:48 INFO - Return code: 0 09:49:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:49:48 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')]} 09:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:48 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')]} 09:49:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:48 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 0x7fb1c50bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1514350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a31c0>, '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 0x15a40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a4550>, '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': '0333a256a5e4f052382dd180000001b1-1468342162.464043-1874228474', '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 09:49:48 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 09:49:48 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 09:49:48 INFO - Using env: {'DISPLAY': ':0', 09:49:48 INFO - 'HOME': '/home/cltbld', 09:49:48 INFO - 'LANG': 'en_US.UTF-8', 09:49:48 INFO - 'LANGUAGE': 'en_US:en', 09:49:48 INFO - 'LOGNAME': 'cltbld', 09:49:48 INFO - 'MAIL': '/var/mail/cltbld', 09:49:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:48 INFO - 'MOZ_NO_REMOTE': '1', 09:49:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:48 INFO - 'NO_EM_RESTART': '1', 09:49:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:48 INFO - 'PWD': '/builds/slave/test', 09:49:48 INFO - 'SHELL': '/bin/bash', 09:49:48 INFO - 'SHLVL': '1', 09:49:48 INFO - 'TERM': 'linux', 09:49:48 INFO - 'TMOUT': '86400', 09:49:48 INFO - 'USER': 'cltbld', 09:49:48 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1468342162.464043-1874228474', 09:49:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:48 INFO - '_': '/tools/buildbot/bin/python'} 09:49:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:49:49 INFO - Running setup.py (path:/tmp/pip-su_yKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:49:49 INFO - Running setup.py (path:/tmp/pip-oLzhay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:49:49 INFO - Running setup.py (path:/tmp/pip-_M1o_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:49:49 INFO - Running setup.py (path:/tmp/pip-AjsNeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:49:49 INFO - Running setup.py (path:/tmp/pip-xiR1SL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:49:49 INFO - Running setup.py (path:/tmp/pip-DLVvPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:49:49 INFO - Running setup.py (path:/tmp/pip-Nw7wEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:49:49 INFO - Running setup.py (path:/tmp/pip-qre5bU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:49:49 INFO - Running setup.py (path:/tmp/pip-NmbF1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:49:49 INFO - Running setup.py (path:/tmp/pip-yTd6Ny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:49:49 INFO - Running setup.py (path:/tmp/pip-5sTnTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:49:49 INFO - Running setup.py (path:/tmp/pip-HyTQgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:49:49 INFO - Running setup.py (path:/tmp/pip-BJ1bbS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:49:49 INFO - Running setup.py (path:/tmp/pip-86aYL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:50 INFO - Running setup.py (path:/tmp/pip-Z8NSCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:49:50 INFO - Running setup.py (path:/tmp/pip-n4sROA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:49:50 INFO - Running setup.py (path:/tmp/pip-e0ZMlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:49:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:49:50 INFO - Running setup.py install for manifestparser 09:49:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:49:50 INFO - Running setup.py install for mozcrash 09:49:50 INFO - Running setup.py install for mozdebug 09:49:50 INFO - Running setup.py install for mozdevice 09:49:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:49:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:49:50 INFO - Running setup.py install for mozfile 09:49:50 INFO - Running setup.py install for mozhttpd 09:49:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:49:50 INFO - Running setup.py install for mozinfo 09:49:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:49:50 INFO - Running setup.py install for mozInstall 09:49:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:49:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:49:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:49:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:49:51 INFO - Running setup.py install for mozleak 09:49:51 INFO - Running setup.py install for mozlog 09:49:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:49:51 INFO - Running setup.py install for moznetwork 09:49:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:49:51 INFO - Running setup.py install for mozprocess 09:49:51 INFO - Running setup.py install for mozprofile 09:49:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:49:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:49:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:49:51 INFO - Running setup.py install for mozrunner 09:49:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:49:51 INFO - Running setup.py install for mozscreenshot 09:49:51 INFO - Running setup.py install for moztest 09:49:51 INFO - Running setup.py install for mozversion 09:49:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:49:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:49:52 INFO - Cleaning up... 09:49:52 INFO - Return code: 0 09:49:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:49:52 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')]} 09:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:52 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')]} 09:49:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:52 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 0x7fb1c50bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1514350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a31c0>, '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 0x15a40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a4550>, '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': '0333a256a5e4f052382dd180000001b1-1468342162.464043-1874228474', '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 09:49:52 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 09:49:52 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 09:49:52 INFO - Using env: {'DISPLAY': ':0', 09:49:52 INFO - 'HOME': '/home/cltbld', 09:49:52 INFO - 'LANG': 'en_US.UTF-8', 09:49:52 INFO - 'LANGUAGE': 'en_US:en', 09:49:52 INFO - 'LOGNAME': 'cltbld', 09:49:52 INFO - 'MAIL': '/var/mail/cltbld', 09:49:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:52 INFO - 'MOZ_NO_REMOTE': '1', 09:49:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:52 INFO - 'NO_EM_RESTART': '1', 09:49:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:52 INFO - 'PWD': '/builds/slave/test', 09:49:52 INFO - 'SHELL': '/bin/bash', 09:49:52 INFO - 'SHLVL': '1', 09:49:52 INFO - 'TERM': 'linux', 09:49:52 INFO - 'TMOUT': '86400', 09:49:52 INFO - 'USER': 'cltbld', 09:49:52 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1468342162.464043-1874228474', 09:49:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:52 INFO - '_': '/tools/buildbot/bin/python'} 09:49:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:49:52 INFO - Running setup.py (path:/tmp/pip-E64PEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:49:52 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)) 09:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:49:52 INFO - Running setup.py (path:/tmp/pip-rLEXhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:49:52 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)) 09:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:49:52 INFO - Running setup.py (path:/tmp/pip-Mop44W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:49:52 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)) 09:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:49:52 INFO - Running setup.py (path:/tmp/pip-UqspWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:49:52 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)) 09:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:49:52 INFO - Running setup.py (path:/tmp/pip-oaHKEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:49:52 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)) 09:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:49:52 INFO - Running setup.py (path:/tmp/pip-aSTY2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:49:52 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)) 09:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:49:52 INFO - Running setup.py (path:/tmp/pip-n1EIGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:49:52 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)) 09:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:49:52 INFO - Running setup.py (path:/tmp/pip-m3fK83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:49:52 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)) 09:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:49:52 INFO - Running setup.py (path:/tmp/pip-KX0CIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:49:52 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)) 09:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:49:52 INFO - Running setup.py (path:/tmp/pip-nqgzmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:49:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 09:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:49:52 INFO - Running setup.py (path:/tmp/pip-1V6vaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:49:53 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)) 09:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:49:53 INFO - Running setup.py (path:/tmp/pip-ztFYqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:49:53 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)) 09:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:49:53 INFO - Running setup.py (path:/tmp/pip-TcvA8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:49:53 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)) 09:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:49:53 INFO - Running setup.py (path:/tmp/pip-_9JQ7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:49:53 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)) 09:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:53 INFO - Running setup.py (path:/tmp/pip-2pB2oJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:53 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)) 09:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:49:53 INFO - Running setup.py (path:/tmp/pip-bKLr4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:49:53 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)) 09:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:49:53 INFO - Running setup.py (path:/tmp/pip-OZLbRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:49:53 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)) 09:49:53 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)) 09:49:53 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)) 09:49:53 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)) 09:49:53 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)) 09:49:53 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)) 09:49:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:49:53 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 09:49:53 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 09:49:53 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 09:49:53 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 09:49:53 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 09:49:53 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 09:49:55 INFO - Downloading blessings-1.6.tar.gz 09:49:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:49:55 INFO - Installing collected packages: blessings 09:49:55 INFO - Running setup.py install for blessings 09:49:55 INFO - Successfully installed blessings 09:49:55 INFO - Cleaning up... 09:49:55 INFO - Return code: 0 09:49:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:49:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:49:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:49:55 INFO - Reading from file tmpfile_stdout 09:49:55 INFO - Current package versions: 09:49:55 INFO - argparse == 1.2.1 09:49:55 INFO - blessings == 1.6 09:49:55 INFO - blobuploader == 1.2.4 09:49:55 INFO - docopt == 0.6.1 09:49:55 INFO - functools32 == 3.2.3-2 09:49:55 INFO - jsonschema == 2.5.1 09:49:55 INFO - manifestparser == 1.1 09:49:55 INFO - mozInstall == 1.12 09:49:55 INFO - mozcrash == 0.17 09:49:55 INFO - mozdebug == 0.1 09:49:55 INFO - mozdevice == 0.48 09:49:55 INFO - mozfile == 1.2 09:49:55 INFO - mozhttpd == 0.7 09:49:55 INFO - mozinfo == 0.9 09:49:55 INFO - mozleak == 0.1 09:49:55 INFO - mozlog == 3.2 09:49:55 INFO - moznetwork == 0.27 09:49:55 INFO - mozprocess == 0.23 09:49:55 INFO - mozprofile == 0.28 09:49:55 INFO - mozrunner == 6.12 09:49:55 INFO - mozscreenshot == 0.1 09:49:55 INFO - mozsystemmonitor == 0.3 09:49:55 INFO - moztest == 0.7 09:49:55 INFO - mozversion == 1.4 09:49:55 INFO - psutil == 3.1.1 09:49:55 INFO - requests == 1.2.3 09:49:55 INFO - wsgiref == 0.1.2 09:49:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:49:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:55 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 0x7fb1c50bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1514350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a31c0>, '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 0x15a40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a4550>, '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': '0333a256a5e4f052382dd180000001b1-1468342162.464043-1874228474', '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 09:49:55 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 09:49:55 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 09:49:55 INFO - Using env: {'DISPLAY': ':0', 09:49:55 INFO - 'HOME': '/home/cltbld', 09:49:55 INFO - 'LANG': 'en_US.UTF-8', 09:49:55 INFO - 'LANGUAGE': 'en_US:en', 09:49:55 INFO - 'LOGNAME': 'cltbld', 09:49:55 INFO - 'MAIL': '/var/mail/cltbld', 09:49:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:55 INFO - 'MOZ_NO_REMOTE': '1', 09:49:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:55 INFO - 'NO_EM_RESTART': '1', 09:49:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:55 INFO - 'PWD': '/builds/slave/test', 09:49:55 INFO - 'SHELL': '/bin/bash', 09:49:55 INFO - 'SHLVL': '1', 09:49:55 INFO - 'TERM': 'linux', 09:49:55 INFO - 'TMOUT': '86400', 09:49:55 INFO - 'USER': 'cltbld', 09:49:55 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1468342162.464043-1874228474', 09:49:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:55 INFO - '_': '/tools/buildbot/bin/python'} 09:49:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:56 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)) 09:49:56 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)) 09:49:56 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)) 09:49:56 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)) 09:49:56 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)) 09:49:56 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)) 09:49:56 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)) 09:49:56 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)) 09:49:56 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)) 09:49:56 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)) 09:49:56 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)) 09:49:56 INFO - Cleaning up... 09:49:56 INFO - Return code: 0 09:49:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:49:56 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')]} 09:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:56 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')]} 09:49:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:56 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 0x7fb1c50bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1514350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a31c0>, '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 0x15a40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a4550>, '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': '0333a256a5e4f052382dd180000001b1-1468342162.464043-1874228474', '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 09:49:56 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 09:49:56 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 09:49:56 INFO - Using env: {'DISPLAY': ':0', 09:49:56 INFO - 'HOME': '/home/cltbld', 09:49:56 INFO - 'LANG': 'en_US.UTF-8', 09:49:56 INFO - 'LANGUAGE': 'en_US:en', 09:49:56 INFO - 'LOGNAME': 'cltbld', 09:49:56 INFO - 'MAIL': '/var/mail/cltbld', 09:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:56 INFO - 'MOZ_NO_REMOTE': '1', 09:49:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:56 INFO - 'NO_EM_RESTART': '1', 09:49:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:56 INFO - 'PWD': '/builds/slave/test', 09:49:56 INFO - 'SHELL': '/bin/bash', 09:49:56 INFO - 'SHLVL': '1', 09:49:56 INFO - 'TERM': 'linux', 09:49:56 INFO - 'TMOUT': '86400', 09:49:56 INFO - 'USER': 'cltbld', 09:49:56 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1468342162.464043-1874228474', 09:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:56 INFO - '_': '/tools/buildbot/bin/python'} 09:49:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:49:56 INFO - Cleaning up... 09:49:56 INFO - Return code: 0 09:49:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:49:56 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')]} 09:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:56 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')]} 09:49:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:56 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c50bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1514350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a31c0>, '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 0x15a40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a4550>, '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': '0333a256a5e4f052382dd180000001b1-1468342162.464043-1874228474', '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 09:49:56 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', 'flake8'] in /builds/slave/test/build 09:49:56 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 flake8 09:49:56 INFO - Using env: {'DISPLAY': ':0', 09:49:56 INFO - 'HOME': '/home/cltbld', 09:49:56 INFO - 'LANG': 'en_US.UTF-8', 09:49:56 INFO - 'LANGUAGE': 'en_US:en', 09:49:56 INFO - 'LOGNAME': 'cltbld', 09:49:56 INFO - 'MAIL': '/var/mail/cltbld', 09:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:56 INFO - 'MOZ_NO_REMOTE': '1', 09:49:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:56 INFO - 'NO_EM_RESTART': '1', 09:49:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:56 INFO - 'PWD': '/builds/slave/test', 09:49:56 INFO - 'SHELL': '/bin/bash', 09:49:56 INFO - 'SHLVL': '1', 09:49:56 INFO - 'TERM': 'linux', 09:49:56 INFO - 'TMOUT': '86400', 09:49:56 INFO - 'USER': 'cltbld', 09:49:56 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1468342162.464043-1874228474', 09:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:56 INFO - '_': '/tools/buildbot/bin/python'} 09:49:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:56 INFO - Downloading/unpacking flake8 09:49:56 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 09:49:56 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 09:49:56 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 09:49:56 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 09:49:56 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 09:49:56 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 09:49:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:49:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:49:58 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 09:49:58 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 09:49:58 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 09:49:58 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 09:49:58 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 09:49:58 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 09:49:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:49:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:49:58 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 09:49:58 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 09:49:58 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 09:49:58 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 09:49:58 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 09:49:58 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 09:49:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:49:58 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 09:49:58 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 09:49:58 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 09:49:58 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 09:49:58 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 09:49:58 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 09:49:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:49:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:49:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:49:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:49:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:49:59 INFO - no previously-included directories found matching 'docs/_build' 09:49:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:49:59 INFO - Running setup.py install for pep8 09:49:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:49:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:49:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:49:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:49:59 INFO - no previously-included directories found matching 'docs/_build' 09:49:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:49:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:49:59 INFO - Cleaning up... 09:49:59 INFO - Return code: 0 09:49:59 INFO - Running post-action listener: _resource_record_post_action 09:49:59 INFO - Running post-action listener: _start_resource_monitoring 09:49:59 INFO - Starting resource monitoring. 09:49:59 INFO - ##### 09:49:59 INFO - ##### Finished create-virtualenv step (success) 09:49:59 INFO - ##### 09:49:59 INFO - ##### 09:49:59 INFO - ##### Running install step. 09:49:59 INFO - ##### 09:49:59 INFO - Running pre-action listener: _resource_record_pre_action 09:49:59 INFO - Running main action method: install 09:49:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:49:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:49:59 INFO - Reading from file tmpfile_stdout 09:49:59 INFO - Detecting whether we're running mozinstall >=1.0... 09:49:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:49:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:49:59 INFO - Reading from file tmpfile_stdout 09:49:59 INFO - Output received: 09:49:59 INFO - Usage: mozinstall [options] installer 09:49:59 INFO - Options: 09:49:59 INFO - -h, --help show this help message and exit 09:49:59 INFO - -d DEST, --destination=DEST 09:49:59 INFO - Directory to install application into. [default: 09:49:59 INFO - "/builds/slave/test"] 09:49:59 INFO - --app=APP Application being installed. [default: firefox] 09:49:59 INFO - mkdir: /builds/slave/test/build/application 09:49:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:49:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:50:15 INFO - Reading from file tmpfile_stdout 09:50:15 INFO - Output received: 09:50:15 INFO - /builds/slave/test/build/application/firefox/firefox 09:50:15 INFO - Running post-action listener: _resource_record_post_action 09:50:15 INFO - ##### 09:50:15 INFO - ##### Finished install step (success) 09:50:15 INFO - ##### 09:50:15 INFO - ##### 09:50:15 INFO - ##### Running run-tests step. 09:50:15 INFO - ##### 09:50:15 INFO - Running pre-action listener: _resource_record_pre_action 09:50:15 INFO - Running main action method: run_tests 09:50:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:50:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:50:15 INFO - Python 2.7.3 09:50:15 INFO - Return code: 0 09:50:15 INFO - grabbing minidump binary from tooltool 09:50: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')]} 09:50:15 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 0x15a31c0>, '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 0x15a40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a4550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:50:15 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 09:50:15 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 09:50:15 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 09:50:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:50:15 INFO - Return code: 0 09:50:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:50:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:50:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:50:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:50:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:50:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:50:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:50:16 INFO - Return code: 0 09:50:16 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:50:16 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:50:16 INFO - Using env: {'DISPLAY': ':0', 09:50:16 INFO - 'HOME': '/home/cltbld', 09:50:16 INFO - 'LANG': 'en_US.UTF-8', 09:50:16 INFO - 'LANGUAGE': 'en_US:en', 09:50:16 INFO - 'LOGNAME': 'cltbld', 09:50:16 INFO - 'MAIL': '/var/mail/cltbld', 09:50:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:50:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:50:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:16 INFO - 'MOZ_NO_REMOTE': '1', 09:50:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:50:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:16 INFO - 'NO_EM_RESTART': '1', 09:50:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:16 INFO - 'PWD': '/builds/slave/test', 09:50:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:50:16 INFO - 'SHELL': '/bin/bash', 09:50:16 INFO - 'SHLVL': '1', 09:50:16 INFO - 'TERM': 'linux', 09:50:16 INFO - 'TMOUT': '86400', 09:50:16 INFO - 'USER': 'cltbld', 09:50:16 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1468342162.464043-1874228474', 09:50:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:16 INFO - '_': '/tools/buildbot/bin/python'} 09:50:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:50:16 INFO - mozversion application_buildid: 20160712071125 09:50:16 INFO - mozversion application_changeset: 50dfed915c24291922414771d3622c336d28b87e 09:50:16 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:50:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:50:16 INFO - mozversion application_name: Firefox 09:50:16 INFO - mozversion application_remotingname: firefox-dev 09:50:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:50:16 INFO - mozversion application_vendor: Mozilla 09:50:16 INFO - mozversion application_version: 49.0a2 09:50:16 INFO - mozversion platform_buildid: 20160712071125 09:50:16 INFO - mozversion platform_changeset: 50dfed915c24291922414771d3622c336d28b87e 09:50:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:50:16 INFO - mozversion platform_version: 49.0a2 09:50:16 INFO - using testdate: 1468342216 09:50:16 INFO - actual date: 1468342216 09:50:16 INFO - starting webserver on 'localhost:45378' 09:50:16 INFO - SUITE-START | Running 2 tests 09:50:16 INFO - TEST-START | dromaeo_css 09:50:16 INFO - operating with platform_type : linux_ 09:50:16 INFO - Initialising browser for dromaeo_css test... 09:50:16 INFO - TEST-INFO | started process 9711 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4pHDMH/profile http://localhost:45378/getInfo.html) 09:50:21 INFO - PROCESS | 9711 | __metrics Screen width/height:1600/1200 09:50:21 INFO - PROCESS | 9711 | colorDepth:24 09:50:21 INFO - PROCESS | 9711 | Browser inner width/height: 1024/697 09:50:21 INFO - PROCESS | 9711 | __metrics 09:50:21 ERROR - PROCESS | 9711 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 09:50:22 INFO - TEST-INFO | 9711: exit 0 09:50:22 INFO - Browser initialized. 09:50:22 INFO - Running cycle 1/1 for dromaeo_css test... 09:50:22 INFO - TEST-INFO | started process 9839 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4pHDMH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:50:34 INFO - PROCESS | 9839 | RSS: Main: 155914240 09:50:34 INFO - PROCESS | 9839 | 09:51:23 INFO - PROCESS | 9839 | 1468342283846 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] 09:53:31 INFO - PROCESS | 9839 | Cycle 1(1): loaded http://localhost:45378/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45378/tests/dromaeo/cssquery-ext.html) 09:53:32 INFO - PROCESS | 9839 | RSS: Main: 159916032 09:53:32 INFO - PROCESS | 9839 | 09:56:34 INFO - PROCESS | 9839 | Cycle 1(1): loaded http://localhost:45378/tests/dromaeo/cssquery-ext.html (next: http://localhost:45378/tests/dromaeo/cssquery-jquery.html) 09:56:34 INFO - PROCESS | 9839 | RSS: Main: 157433856 09:56:34 INFO - PROCESS | 9839 | 09:59:36 INFO - PROCESS | 9839 | Cycle 1(1): loaded http://localhost:45378/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45378/tests/dromaeo/cssquery-mootools.html) 09:59:37 INFO - PROCESS | 9839 | RSS: Main: 156782592 09:59:37 INFO - PROCESS | 9839 | 10:02:39 INFO - PROCESS | 9839 | Cycle 1(1): loaded http://localhost:45378/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45378/tests/dromaeo/cssquery-prototype.html) 10:02:39 INFO - PROCESS | 9839 | RSS: Main: 156618752 10:02:39 INFO - PROCESS | 9839 | 10:05:42 INFO - PROCESS | 9839 | Cycle 1(1): loaded http://localhost:45378/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45378/tests/dromaeo/cssquery-yui.html) 10:05:42 INFO - PROCESS | 9839 | RSS: Main: 158892032 10:05:42 INFO - PROCESS | 9839 | 10:08:44 INFO - PROCESS | 9839 | Cycle 1(1): loaded http://localhost:45378/tests/dromaeo/cssquery-yui.html (next: http://localhost:45378/tests/dromaeo/cssquery-dojo.html) 10:08:45 INFO - PROCESS | 9839 | RSS: Main: 158969856 10:08:45 INFO - PROCESS | 9839 | 10:08:45 INFO - PROCESS | 9839 | __start_tp_report 10:08:45 INFO - PROCESS | 9839 | _x_x_mozilla_page_load 10:08:45 INFO - PROCESS | 9839 | _x_x_mozilla_page_load_details 10:08:45 INFO - PROCESS | 9839 | |i|pagename|runs| 10:08:45 INFO - PROCESS | 9839 | |0;dojo.html;3329.200991761977;3359.143418428301;3379.7803142795733;3379.9831000844993;3400.0479865637612;5504.889902201953;5517.393086760453;5522.751476183571;5530.806421775239;5582.8325150245455;5546.750396232169;5593.133064375018;5602.579806514507;5611.270534830466;5677.318721753385;5055.823046193384;5108.20822772469;5182.481751824825;5196.281816005748;5200.219967004941;5037.5718063964605;5042.722650254234;5086.92369614456;5205.063088644042;5217.191335343028;5021.6986980781085;5046.949530504685;5094.898102037957;5106.310648062501;5110.795568177268;5058.544730974211;5092.490750924915;5094.79620815167;5100;5127.717975511346;4891.364122664067;4976.726280054596;5016.197408414672;5052.46949070346;5073.670211436245;5381.354237491487;5426.104692725696;5472.151816468454;5473.233747275384;5488.56091512678;5962.07587823888;5980.55145864062;5990.071538911432;6003.609765365237;6007.369226231226;5860.736266868002;5947.672877991708;6055.939440605582;6069.271687397496;6078.149059131725;5596.916046259309;5633.549316054747;5640.915386269209;5647.830565083054;5668.801591944262;6114.602550834182;6118.5716999810475;6130.141780150782;6136.386361363828;6136.447719705248;5626.043572592587;5865.266841644794;5884.6469211847425;5888.028475301613;5903.3801450847905;6038.275406951107;6038.758449661965;6042.395760423922;6054;6084.939150608438;5906.527477801766;5948.375420580864;6006.849828754229;6009.188759517497;6033.637981721111;5707.942920570824;5916.3787802281;5928.703564821742;5935.406459354116;5992.34084250732;4572.51988541205;4596.655250856199;4612.169809434334;4613.5386461354265;4635.791389387486;4119.732217405919;4133.648639865645;4134.524529679125;4155.646770024521;4163.854265100767;5525.806596769175;5683.943160568341;5696.401877802771;5737.512311453574;5775.27809023872;5980.73086711099;6032.819015429544;6052.273727152769;6114.419130182626;6126.724297406628;5640.351359593699;5756.136579513023;5864.354920958691;5867.882642347129;5870.236869206976;5121.359830021247;5132.640715149978;5158.767855446514;5158.793648254103;5198.92201616976;6211.627302361872;6242.438180563771;6252.781152659635;6263.530235232284;6293.465055470337;5970.611910225822;5978.461938425563;5989.401059893976;5989.730462129215;6024.397560244116;6086.269647642312;6115.483736156635;6139.96930015365;6153.5692501526255;6237.28271248794;5804.535637148933;5845.064789633639;5857.677827719516;5860.941390586039;5868.002439585195;5835.183074369676;5923.111533270044;5942.58401911862;5957.672328022;5970.492508136857;5720.656760594377;5721.628094173865;5792.7103644818435;5802.245708058094;5805.8548536286935;5729.455701708331;5786.623869448473;5800.187973683772;5823.621464604787;5830.300363956352;5650.604457688087;5715.828525144252;5722.599418040863;5732.398098199796;5740.598158128891;5861.9706901465215;5903.26209223847;5944.821655350346;5958.285005799332;5962.940370596239;5773.16289138081;5796.971015144897;5800.738966746591;5803.129530570448;5806.912896306474 10:08:45 INFO - PROCESS | 9839 | |1;ext.html;597.1371368372703;639.9264084630267;647.6437959122482;648.5330561995363;657.7500549791082;45453.318200227026;46486.53513464864;46525.30212046822;46583;50733.49266507343;49251.75374123133;49514.50485495144;49709.25436118452;49843.25235121476;49849.50150498503;8789.989151247608;8876.201141897229;8901.955490222539;8902.243309318716;8930.598123084477;9038.593263303168;9039.909600903973;9078.500682462462;9096.044915283866;9110.27117830572;9055.230305424047;9081.95459022704;9105.226055785233;9120.543972801366;9131.0412406697;9099;9130.771730706752;9143.451392916446;9166.495842728647;9167.862482062708;9037.593308301142;9093.818123637557;9099.363044586882;9105.681301154427;9112.271018318519;45829;45934;46042.30936535955;46087.76956115198;46242.07515849698;3819.312523745725;3888.7083468739675;4394.318880573516;4423.093265880487;4459.799309031101;33946.83026584876;34091;34134.829325853214;34297.48553771695;35607;4442.378067070613;4474.82100715971;4509.030558429953;4564.406627138451;4590.150822097922;380043;380044;380365;382808.0859595712;383812;37244.25511489755;61304;61737.38262617406;61809.69095154495;61816;38156;39844.402333965016;40183;40405.79797101054;40417.79791101025;15185.696286074217;15210.619734506727;15661.138637375054;15750.448734294245;15762.921185394;13407.731845363038;13630.386632601556;13802.964777641717;13804.792928106086;13839.930800345934;9006.459612423276;9014.278857691368;9106.362554621113;9106.544672766335;9171.954140229256;3501.7898926064518;3507.824608769551;3571.4642803579673;3576.8748093816594;3577.5170352002665;1083.7344850511674;1088.450332582041;1135.330155208431;1172.7654469106042;1224.1920332580455;32722.67277327244;33324.83337583297;33924.1518962023;33979.32041359208;34098.48852267218;1105.9447027648584;1133.345315838868;1163.4764356039816;1237.9133460657667;1274.5284244829472;17142.742858857127;17165.485035448957;17248.82751172472;17414.477565672798;17648.823511764716;608600;629886;634096;635992;1025430;61846.38153618496;69744;70151;70203;70270;1491.9030263032869;1523.8552337527917;1537.4388348252808;1542.845715428448;1553.068159104551;33832.3233535323;34062.829685851415;34371.31257374889;34574.65425345714;34646.65353346434;57515;57973;58044;58287.70856145862;58449.70775146097;521971;527006;528230;530518;531020;48339.27491087566;48438;48632.51367486421;48837.51162488329;49069.2639610399;52861.47138528565;53629.7318513405;53841.19238211351;53961.73019135036;54690;44818.551814482744;45299.32051019171;45692.54307457016;46308.30537542007;46375.76812115918;44498.555014450736;44641.33038004497;45039.324410134526;46149.769251154874;46313;44948.325775114055;45497.61622455564;45602.77198614118;45919;46008.769956151344;39645.60354396534;39688.80155599204;39898.800505997286;40232.79883600563;40552.391714123725;30542.10217497244;30605.540916886708;30631.846840766546;31078.844605776827;31282 10:08:45 INFO - PROCESS | 9839 | |2;jquery.html;423.1579157476622;423.18114448542053;427.60446586907113;428.5286185196284;443.35270505062607;18749.156287967042;19867.20531178753;20393.286234981777;21363.57272854542;21378.57242855142;19706.310279140234;19900;20663.896680516576;20727.896360518178;20855.165793368247;5637.718114094289;5826.184334193216;5869.8239052828485;5878.794242201524;5889.1755154278435;5632.746526406321;5736.196932429463;5742.885142297151;5830;5845.912311315313;5768.336641286242;5782.45066718661;5784.1902133701315;5806.332271788756;5810.622309549887;5658.43415658435;5752.971235143818;5788.102844059156;5789.189513468118;5832.2418085649015;5254.185601231815;5254.868628284324;5255.080360936859;5269.499397557226;5287.524122828964;23391.298261052194;23947.40131496709;24384.634230486557;24418.755812441825;24651;2582.7029891562333;2826.3075546491036;2840.3751174741524;2869.540873460257;2896.4641541314923;10018.89981100187;10475.633352832614;10477.738056548571;14869.107853528823;15790.447334343358;2021.4744166516812;2023.2412845183057;2030.6649402848511;2043.4176259765895;2095.800898914616;87178.56410717906;87909.56045219733;89596.55201723949;89892.10107898903;91527;11643.76712465746;11693.532258709556;11898.940505297418;11915.76168476643;12069.27584344942;16608.25262863174;16827.663446730996;16865.91567042157;16867.409640662518;16877.578060548585;8784.912150878537;8813.162749538784;8911.910880891237;8928.776780580407;9037.909620903838;8616.870746938801;8631.525266110424;8645.481271123752;8655.956720216358;8725.476471411608;5020.698758074527;5063.620228482879;5069.188929771219;5125.923111153335;5127.179651255781;2021.7371741673783;2080.8127268545904;2135.1993002624017;2138.860974036683;2173.500094978164;964.5804075227298;1013.5591017907234;1052.2055847834836;1092.819684752023;1153.2503872482785;19544.609107817763;19582.412527624194;19762.11070501831;20029.799702002794;20307.695384569244;1057.370864335719;1073.8496610474383;1093.4314156638504;1095.6767753512734;1127.7575321305958;11127.610533631447;11250.943745281222;11320.886791132149;11344;11392.544298227978;489600;493317;502327;504069;507817;96715.51642241744;100099.49950250347;100184.49907750415;101314.49342753239;102626;1058.0636137018794;1064.531606093332;1118.983215251772;1150.1259043127116;1150.7180740718577;17257.74113388275;17620.647587048443;17659.646807064044;17993.460196194133;17996.820031799514;40596.79701601473;41453;41903.79048104862;41985.16029679451;43617.345739813296;59941.40058599358;61354.69322653358;61529.077063844976;61598;61635;7889.4871833332945;7906.52560846328;8421.95789021051;8712.869306960527;9172.862407064033;13070.673233168867;13416.1279516835;13669.726605468033;13699.657508562366;13921.79117313221;12043.638690839289;12285.57000504978;12338;12724.681882953;12845.165064270792;12141.210821296587;12141.575044873387;12308.076894232789;12690.746185076432;12845.743085138432;12279.508819647113;12309.44607492647;12326.383680816103;12408.441620126936;12414.131010829517;8344.123866993878;8536.487810731376;8589.312854971713;8625.309975202093;8708.085651006553;11930.284182949052;12374.319412432402;12384;12476.563320283747;12639.304838233986 10:08:45 INFO - PROCESS | 9839 | |3;mootools.html;1575.5115914066637;1616.3211451190502;1814.1382843149506;1893.9810601893985;1894.5642502224496;9349.672761453341;9685.225181985443;9948.104670579647;10094.09153176214;10138.695839124819;9836.360636558618;9911.504424778768;9961.501924903761;9966.601335946554;10205.438700871468;2513.22090152053;2536.708278547963;2545.338212064858;2550.41340491687;2556.923292301234;2480.3303108160785;2513.0952856971567;2517.848929064262;2524.5960646296594;2527.936801579966;2466.2971053249826;2476.9009239630395;2486.0925762096886;2493.2644869763462;2500.6999160100722;2447.045652195654;2451.570975079363;2456.9631455528183;2492.476579918219;2499.9250022499355;2406.2420337593603;2421.878906054708;2421.9152329668555;2442.7312995570474;2527.431327951215;9694.709158725249;9819.852702209473;9836.409815411098;9849.113579777855;9868.358556693793;5730.885382292373;5831.096180092092;5840.912386314166;5854.7072646367515;5863.941360586382;3596;3650.507181530486;3753.3244016077097;3790.4124860646643;3818.102745854722;1152.3316476443642;1158.4960542164101;1167.5096459487036;1177.3171560494893;1195.1394995603152;13795.2412617306;13846.169229846242;13907.304634768221;13912.58262252134;13943.790843137362;4745.881352966135;4841.9031619367415;4892.412910450697;4952.276248063551;4979.651424400329;10956.890431095746;10964.122870170368;10993.670189894316;11010.174236932262;11011.61459348919;5618.410066942994;5685.857853553612;5687.544996400278;5724.398938111522;5725.5133313667975;4434.623057040188;4904.043711476228;5038.345015148007;5048.217526283432;5331.306930099062;4206.3690446432665;4207.116505533811;4211.915761684749;4223.21870453967;4223.746575205498;1236.1223531292883;1254.1221145198397;1262.059765474709;1278.622806272152;1288.0275392079109;988.9159421449258;1020.1532727836027;1024.5799222318813;1038.3717850700368;1048.124815778818;6085.847853803691;6156.5998210116195;6187.443130118311;6234.719437625317;6237.875242495124;478.4450037955954;480.2603989855653;480.86295405809176;482.15141351222104;500.36453703795974;4120.320147175742;4121.381792731115;4129.050318426779;4159.313713237282;4182.832686692498;11873.762524749456;12288.938555307166;12379.257244565355;12382.380880955916;12389.566365177176;12139.210951288314;12189.939050304693;12281.263124212575;12289.815652765215;12296.139270250997;8578.142185781497;8899.955500222457;8924.8661270081;9178.357514973888;9181.816363672822;6221.4089661482085;6393.808185754435;6421.486281097407;6477.740890364333;6485.740570377132;11160.88839111631;11263.042641375574;11381.886181138083;11443.713907152387;11484.425778710864;11207.327560346404;11448;11666.416679166177;11719.179657423898;11867.347295898464;7741;7942.166072562529;8089.271965523131;8456.069832318317;8644.78388040304;9072;9101.954490227507;9121.407108537924;9139.58871850755;9158.450492970444;7805.492642978188;7997.680092796223;8038.356931445353;8046.476978996347;8400.915990840012;7871.173526779606;7905.723299684483;8019.318357939641;8080.919190808252;8147.674093036212;7386.519876208029;7428.777136685908;7510.737124200627;7566.924330756842;7583.203763604963;5055.393352797688;5059.5952323814745;5123.257127716534;5128.512791284822;5147.3308469898675;5298.257506280136;5401.86495337604;5411.918821217606;5445.945540544702;5514.145307477347 10:08:45 INFO - PROCESS | 9839 | |4;prototype.html;356.1647935591038;364.9251903359811;364.97992610406436;374.31873989339397;376.5707093912938;5610.270664813579;5698.6865722385255;5756.942430575698;5824.271966004249;5826.9999999999945;5709.457601527859;5713.771449142039;5723.481668066048;5728.942710572893;5740.942590574093;4426.557344265564;4441.822327106928;4478.305862591304;4501.077279157765;4510.594046535811;4420.005498762785;4496.6627502937245;4510.210713125206;4514.52597477265;4523.208438523262;4420.8673739787855;4467.597916187542;4468.932966005513;4473.396091527635;4485.237509623372;4442.311441726538;4455.955440445587;4460.754658493782;4466.665000124987;4475.597196252353;3974.4038394240806;3987.7407968481957;3993.1414745829497;4014.2573623879675;4062.5124985001694;5454.91817622736;5465.890682186334;5476;5476.808311709111;5485.753141108659;5115.590752739772;5159.896802063975;5179.669148883017;5208.583313334924;5212.582993360522;5822.321732003284;6008.699565021731;6010.429009244115;6053;6090.5736598438125;4323.610875021232;4348.260795664744;4366.257736184824;4439.156560253541;4445.355423463612;6129.957907155795;6259.7496100156395;6277.372262773732;6307.684615769239;6367.140436041122;4335.956640433618;4485.820567177341;4493.483249426358;4493.955060449353;4501.954980450219;4548.931766023512;4562.794674239667;4583.770811459413;4606.792694328763;4616.3537104805355;5185.7407129644125;5188.948110518922;5227.895442091137;5244.5279924806955;5258.447862974409;5880.0297950838485;5935.40645935403;5997.670128142907;6048.939510604838;6070.028795392716;1536.5467187179809;1552.767084937246;1559.50095969291;1560.141921942927;1567.5656774051843;975.3465178330536;978.9559469823876;994.7363948553639;1002.3384566186282;1010.5856598794459;5220.947790522122;5221.503957124143;5225.451327610622;5242.715534694024;5244.187150991603;5502.477264659851;5548.8082207527805;5571.554275657938;5606.635568688022;5624.493795558419;4881.9023619528125;5226.686398816083;5256.342957130359;5263.236830659533;5368.436314187033;2893.363460038788;2902.288939209865;2960.7335339819087;2976.5088760354733;2985.805922615023;5671.72386213107;5714.200011998323;5766.711664416763;5805.448482394166;5825.271841019872;5894.410558944071;6348.77779277723;6357.4914006879335;6362.681865906686;6363.7772677956045;6428.682120165448;6455.61266324022;6492.415682588589;6498.707558159894;6511.576747511492;5985.6408615483215;6168.660723660242;6195.349488303844;6209.8201341744925;6212.316645168938;6120.846978825387;6139.785107521216;6163.599366041193;6174.475169610454;6219.689015549295;6116.66358350295;6420.775272865428;6466.902996454963;6490.772822951174;6554.2462616797775;4368.2355587772645;4383.904023994001;4433.357163211252;4452.398926144929;4464.17412778637;6082.300535438304;6117.510599151969;6368.968155159195;6371.808845734636;6421.775237866652;5982.312034116132;5987.31145918225;6001.2498437695285;6006;6031.728572214173;5899.528037756883;5987.700614969322;6008.399160084132;6011.609245399035;6034.788782392595;5703.230063941315;5958.314793798769;6015.187949626919;6027.2164618601055;6062.545309101747;6083.8174854754425;6109.633421994695;6116.3272040076445;6130.785422510191;6137.140800287874;5603.663780173202;5918.461200087922;5927.733252003584;5941.910871336847;6004.268058033672 10:08:45 INFO - PROCESS | 9839 | |5;yui.html;735.6321839080459;744.7393412305694;778.0080397493196;792.635387721648;792.7582087463321;13108.60674179775;13396.263205523692;13559.050866439353;13604.387802548885;13787.931060344697;15299.84700152998;15544.68910621787;15664.216789160553;15692.215389230521;15703.37186512541;710.1088134391357;855.8331125430543;858.1247127929523;879.2965627498008;879.4459490520995;877.4384393987852;880.6741505642921;883.902770695223;885.3227281129941;886.6409104312731;685.1298850459913;687.6321168175027;689.8068540808556;691.4502970138752;700.898369736388;687.8074139241021;689.5586824432368;692.2765709833236;692.8164036530324;697.5012865800977;524.779592571121;529.986750331241;531.9920201196985;533.8291746641077;537.1298496435799;15611.375544978187;15673.608159795982;15704.214789260492;15714.44999425026;15744;15745.291461884128;15944.601384965352;16050.839491605167;16256.674866502723;16305;12813.807792883114;13088.411021504055;13211.933940330333;13229.140105893086;13365.933170334183;3978.403239514067;3992.6207010333974;4094.4063110849056;4099.159672267178;4215.22018426589;82762.58618706868;83280;83633;84114.57942710309;84669;11622;11766.764664706658;11812.40937953099;11897.881021189678;12130.150889437831;20135.697964530544;20594.691079633816;20834.47913802137;20873.26943556968;20905.163793448395;9185.908140918638;9228.538573071453;9297.30270229722;9472.194863436685;9510.476923769122;4736.052789442126;4792.95207047925;4894.26586012094;4946.579540739005;4956.727379994135;3885.825137868803;4012.27778999777;4013.2776100302226;4014.417909403179;4016.0562267867026;693.9271376505495;698.4935921457005;705.544923524324;706.6113637499354;707.3351050013074;628.9496840252768;720.7405334079727;755.3466251692356;783.9255270749384;803.7869964459423;10615.256932014685;10817.621383251548;10850.240483166102;10886.129109671207;10894.891051089546;628.3653509954887;671.4628297362091;735.9328972989188;756.4402342266793;780.8594452998401;4781.713097214179;5011.5489605935645;5051.292819005343;5070.163423035158;5119.564836988823;80551;120717.39641301737;123071.23736465657;123710;125287.3735631316;66317.66841165764;66440;69542;90356;109639;61319.693401532706;61445;61587;62321;98393.50803246081;9661.71014869555;9808.411495310304;9822;9886.209103271865;10035.648752293635;39339.60660393359;43949.56050439455;55868.44131558632;56267.43732562622;56523.71738141283;71363;83020;85789.57105214434;87746;88497;12433.813492797795;12590.937045314715;12593.370331483573;12920.741585168433;12999.285039322927;14188.929055354658;14246.857531424554;14294.571162865132;14366.56900292993;14403.279836008367;13200.801987969997;13562.93218533901;13591.660208494866;13799.310034498034;13957.860421396063;13288;13377.53178638743;13411.463541458623;13542;13649.931750341184;12715.364231788188;12752.298623575793;13022.348882556023;13327.333633318489;13360.93319533396;10951;10972;11083.944580277048;11131;11161.88838111641;10924.344539327665;11107.166962477684;11186.161037922351;11324.716882078013;11393.801444565934 10:08:45 INFO - PROCESS | 9839 | __end_tp_report 10:08:45 INFO - PROCESS | 9839 | __start_cc_report 10:08:45 INFO - PROCESS | 9839 | _x_x_mozilla_cycle_collect,323 10:08:45 INFO - PROCESS | 9839 | __end_cc_report 10:08:45 INFO - PROCESS | 9839 | __startTimestamp1468343325073__endTimestamp 10:08:45 INFO - PROCESS | 9839 | 10:08:45 INFO - PROCESS | 9839 | ------- Summary: start ------- 10:08:45 INFO - PROCESS | 9839 | Number of tests: 6 10:08:45 INFO - PROCESS | 9839 | 10:08:45 INFO - PROCESS | 9839 | [#0] dojo.html Cycles:165 Average:5561.23 Median:5775.28 stddev:611.98 (10.6%) stddev-sans-first:588.28 10:08:45 INFO - PROCESS | 9839 | Values: 3329.2 3359.1 3379.8 3380.0 3400.0 5504.9 5517.4 5522.8 5530.8 5582.8 5546.8 5593.1 5602.6 5611.3 5677.3 5055.8 5108.2 5182.5 5196.3 5200.2 5037.6 5042.7 5086.9 5205.1 5217.2 5021.7 5046.9 5094.9 5106.3 5110.8 5058.5 5092.5 5094.8 5100.0 5127.7 4891.4 4976.7 5016.2 5052.5 5073.7 5381.4 5426.1 5472.2 5473.2 5488.6 5962.1 5980.6 5990.1 6003.6 6007.4 5860.7 5947.7 6055.9 6069.3 6078.1 5596.9 5633.5 5640.9 5647.8 5668.8 6114.6 6118.6 6130.1 6136.4 6136.4 5626.0 5865.3 5884.6 5888.0 5903.4 6038.3 6038.8 6042.4 6054.0 6084.9 5906.5 5948.4 6006.8 6009.2 6033.6 5707.9 5916.4 5928.7 5935.4 5992.3 4572.5 4596.7 4612.2 4613.5 4635.8 4119.7 4133.6 4134.5 4155.6 4163.9 5525.8 5683.9 5696.4 5737.5 5775.3 5980.7 6032.8 6052.3 6114.4 6126.7 5640.4 5756.1 5864.4 5867.9 5870.2 5121.4 5132.6 5158.8 5158.8 5198.9 6211.6 6242.4 6252.8 6263.5 6293.5 5970.6 5978.5 5989.4 5989.7 6024.4 6086.3 6115.5 6140.0 6153.6 6237.3 5804.5 5845.1 5857.7 5860.9 5868.0 5835.2 5923.1 5942.6 5957.7 5970.5 5720.7 5721.6 5792.7 5802.2 5805.9 5729.5 5786.6 5800.2 5823.6 5830.3 5650.6 5715.8 5722.6 5732.4 5740.6 5862.0 5903.3 5944.8 5958.3 5962.9 5773.2 5797.0 5800.7 5803.1 5806.9 10:08:45 INFO - PROCESS | 9839 | 10:08:45 INFO - PROCESS | 9839 | [#1] ext.html Cycles:180 Average:69770.85 Median:45760.77 stddev:150640.21 (329.2%) stddev-sans-first:150973.26 10:08:45 INFO - PROCESS | 9839 | Values: 597.1 639.9 647.6 648.5 657.8 45453.3 46486.5 46525.3 46583.0 50733.5 49251.8 49514.5 49709.3 49843.3 49849.5 8790.0 8876.2 8902.0 8902.2 8930.6 9038.6 9039.9 9078.5 9096.0 9110.3 9055.2 9082.0 9105.2 9120.5 9131.0 9099.0 9130.8 9143.5 9166.5 9167.9 9037.6 9093.8 9099.4 9105.7 9112.3 45829.0 45934.0 46042.3 46087.8 46242.1 3819.3 3888.7 4394.3 4423.1 4459.8 33946.8 34091.0 34134.8 34297.5 35607.0 4442.4 4474.8 4509.0 4564.4 4590.2 380043.0 380044.0 380365.0 382808.1 383812.0 37244.3 61304.0 61737.4 61809.7 61816.0 38156.0 39844.4 40183.0 40405.8 40417.8 15185.7 15210.6 15661.1 15750.4 15762.9 13407.7 13630.4 13803.0 13804.8 13839.9 9006.5 9014.3 9106.4 9106.5 9172.0 3501.8 3507.8 3571.5 3576.9 3577.5 1083.7 1088.5 1135.3 1172.8 1224.2 32722.7 33324.8 33924.2 33979.3 34098.5 1105.9 1133.3 1163.5 1237.9 1274.5 17142.7 17165.5 17248.8 17414.5 17648.8 608600.0 629886.0 634096.0 635992.0 1025430.0 61846.4 69744.0 70151.0 70203.0 70270.0 1491.9 1523.9 1537.4 1542.8 1553.1 33832.3 34062.8 34371.3 34574.7 34646.7 57515.0 57973.0 58044.0 58287.7 58449.7 521971.0 527006.0 528230.0 530518.0 531020.0 48339.3 48438.0 48632.5 48837.5 49069.3 52861.5 53629.7 53841.2 53961.7 54690.0 44818.6 45299.3 45692.5 46308.3 46375.8 44498.6 44641.3 45039.3 46149.8 46313.0 44948.3 45497.6 45602.8 45919.0 46008.8 39645.6 39688.8 39898.8 40232.8 40552.4 30542.1 30605.5 30631.8 31078.8 31282.0 10:08:45 INFO - PROCESS | 9839 | 10:08:45 INFO - PROCESS | 9839 | [#2] jquery.html Cycles:180 Average:30234.47 Median:11758.72 stddev:82592.16 (702.4%) stddev-sans-first:82793.52 10:08:45 INFO - PROCESS | 9839 | Values: 423.2 423.2 427.6 428.5 443.4 18749.2 19867.2 20393.3 21363.6 21378.6 19706.3 19900.0 20663.9 20727.9 20855.2 5637.7 5826.2 5869.8 5878.8 5889.2 5632.7 5736.2 5742.9 5830.0 5845.9 5768.3 5782.5 5784.2 5806.3 5810.6 5658.4 5753.0 5788.1 5789.2 5832.2 5254.2 5254.9 5255.1 5269.5 5287.5 23391.3 23947.4 24384.6 24418.8 24651.0 2582.7 2826.3 2840.4 2869.5 2896.5 10018.9 10475.6 10477.7 14869.1 15790.4 2021.5 2023.2 2030.7 2043.4 2095.8 87178.6 87909.6 89596.6 89892.1 91527.0 11643.8 11693.5 11898.9 11915.8 12069.3 16608.3 16827.7 16865.9 16867.4 16877.6 8784.9 8813.2 8911.9 8928.8 9037.9 8616.9 8631.5 8645.5 8656.0 8725.5 5020.7 5063.6 5069.2 5125.9 5127.2 2021.7 2080.8 2135.2 2138.9 2173.5 964.6 1013.6 1052.2 1092.8 1153.3 19544.6 19582.4 19762.1 20029.8 20307.7 1057.4 1073.8 1093.4 1095.7 1127.8 11127.6 11250.9 11320.9 11344.0 11392.5 489600.0 493317.0 502327.0 504069.0 507817.0 96715.5 100099.5 100184.5 101314.5 102626.0 1058.1 1064.5 1119.0 1150.1 1150.7 17257.7 17620.6 17659.6 17993.5 17996.8 40596.8 41453.0 41903.8 41985.2 43617.3 59941.4 61354.7 61529.1 61598.0 61635.0 7889.5 7906.5 8422.0 8712.9 9172.9 13070.7 13416.1 13669.7 13699.7 13921.8 12043.6 12285.6 12338.0 12724.7 12845.2 12141.2 12141.6 12308.1 12690.7 12845.7 12279.5 12309.4 12326.4 12408.4 12414.1 8344.1 8536.5 8589.3 8625.3 8708.1 11930.3 12374.3 12384.0 12476.6 12639.3 10:08:45 INFO - PROCESS | 9839 | 10:08:45 INFO - PROCESS | 9839 | [#3] mootools.html Cycles:180 Average:6289.21 Median:4223.48 stddev:3727.46 (88.3%) stddev-sans-first:3721.08 10:08:45 INFO - PROCESS | 9839 | Values: 1575.5 1616.3 1814.1 1894.0 1894.6 9349.7 9685.2 9948.1 10094.1 10138.7 9836.4 9911.5 9961.5 9966.6 10205.4 2513.2 2536.7 2545.3 2550.4 2556.9 2480.3 2513.1 2517.8 2524.6 2527.9 2466.3 2476.9 2486.1 2493.3 2500.7 2447.0 2451.6 2457.0 2492.5 2499.9 2406.2 2421.9 2421.9 2442.7 2527.4 9694.7 9819.9 9836.4 9849.1 9868.4 5730.9 5831.1 5840.9 5854.7 5863.9 3596.0 3650.5 3753.3 3790.4 3818.1 1152.3 1158.5 1167.5 1177.3 1195.1 13795.2 13846.2 13907.3 13912.6 13943.8 4745.9 4841.9 4892.4 4952.3 4979.7 10956.9 10964.1 10993.7 11010.2 11011.6 5618.4 5685.9 5687.5 5724.4 5725.5 4434.6 4904.0 5038.3 5048.2 5331.3 4206.4 4207.1 4211.9 4223.2 4223.7 1236.1 1254.1 1262.1 1278.6 1288.0 988.9 1020.2 1024.6 1038.4 1048.1 6085.8 6156.6 6187.4 6234.7 6237.9 478.4 480.3 480.9 482.2 500.4 4120.3 4121.4 4129.1 4159.3 4182.8 11873.8 12288.9 12379.3 12382.4 12389.6 12139.2 12189.9 12281.3 12289.8 12296.1 8578.1 8900.0 8924.9 9178.4 9181.8 6221.4 6393.8 6421.5 6477.7 6485.7 11160.9 11263.0 11381.9 11443.7 11484.4 11207.3 11448.0 11666.4 11719.2 11867.3 7741.0 7942.2 8089.3 8456.1 8644.8 9072.0 9102.0 9121.4 9139.6 9158.5 7805.5 7997.7 8038.4 8046.5 8400.9 7871.2 7905.7 8019.3 8080.9 8147.7 7386.5 7428.8 7510.7 7566.9 7583.2 5055.4 5059.6 5123.3 5128.5 5147.3 5298.3 5401.9 5411.9 5445.9 5514.1 10:08:45 INFO - PROCESS | 9839 | 10:08:45 INFO - PROCESS | 9839 | [#4] prototype.html Cycles:180 Average:5017.50 Median:5605.15 stddev:1476.23 (26.3%) stddev-sans-first:1438.32 10:08:45 INFO - PROCESS | 9839 | Values: 356.2 364.9 365.0 374.3 376.6 5610.3 5698.7 5756.9 5824.3 5827.0 5709.5 5713.8 5723.5 5728.9 5740.9 4426.6 4441.8 4478.3 4501.1 4510.6 4420.0 4496.7 4510.2 4514.5 4523.2 4420.9 4467.6 4468.9 4473.4 4485.2 4442.3 4456.0 4460.8 4466.7 4475.6 3974.4 3987.7 3993.1 4014.3 4062.5 5454.9 5465.9 5476.0 5476.8 5485.8 5115.6 5159.9 5179.7 5208.6 5212.6 5822.3 6008.7 6010.4 6053.0 6090.6 4323.6 4348.3 4366.3 4439.2 4445.4 6130.0 6259.7 6277.4 6307.7 6367.1 4336.0 4485.8 4493.5 4494.0 4502.0 4548.9 4562.8 4583.8 4606.8 4616.4 5185.7 5188.9 5227.9 5244.5 5258.4 5880.0 5935.4 5997.7 6048.9 6070.0 1536.5 1552.8 1559.5 1560.1 1567.6 975.3 979.0 994.7 1002.3 1010.6 5220.9 5221.5 5225.5 5242.7 5244.2 5502.5 5548.8 5571.6 5606.6 5624.5 4881.9 5226.7 5256.3 5263.2 5368.4 2893.4 2902.3 2960.7 2976.5 2985.8 5671.7 5714.2 5766.7 5805.4 5825.3 5894.4 6348.8 6357.5 6362.7 6363.8 6428.7 6455.6 6492.4 6498.7 6511.6 5985.6 6168.7 6195.3 6209.8 6212.3 6120.8 6139.8 6163.6 6174.5 6219.7 6116.7 6420.8 6466.9 6490.8 6554.2 4368.2 4383.9 4433.4 4452.4 4464.2 6082.3 6117.5 6369.0 6371.8 6421.8 5982.3 5987.3 6001.2 6006.0 6031.7 5899.5 5987.7 6008.4 6011.6 6034.8 5703.2 5958.3 6015.2 6027.2 6062.5 6083.8 6109.6 6116.3 6130.8 6137.1 5603.7 5918.5 5927.7 5941.9 6004.3 10:08:45 INFO - PROCESS | 9839 | 10:08:45 INFO - PROCESS | 9839 | [#5] yui.html Cycles:180 Average:20328.85 Median:4157.19 stddev:28990.82 (697.4%) stddev-sans-first:29034.81 10:08:45 INFO - PROCESS | 9839 | Values: 735.6 744.7 778.0 792.6 792.8 13108.6 13396.3 13559.1 13604.4 13787.9 15299.8 15544.7 15664.2 15692.2 15703.4 710.1 855.8 858.1 879.3 879.4 877.4 880.7 883.9 885.3 886.6 685.1 687.6 689.8 691.5 700.9 687.8 689.6 692.3 692.8 697.5 524.8 530.0 532.0 533.8 537.1 15611.4 15673.6 15704.2 15714.4 15744.0 15745.3 15944.6 16050.8 16256.7 16305.0 12813.8 13088.4 13211.9 13229.1 13365.9 3978.4 3992.6 4094.4 4099.2 4215.2 82762.6 83280.0 83633.0 84114.6 84669.0 11622.0 11766.8 11812.4 11897.9 12130.2 20135.7 20594.7 20834.5 20873.3 20905.2 9185.9 9228.5 9297.3 9472.2 9510.5 4736.1 4793.0 4894.3 4946.6 4956.7 3885.8 4012.3 4013.3 4014.4 4016.1 693.9 698.5 705.5 706.6 707.3 628.9 720.7 755.3 783.9 803.8 10615.3 10817.6 10850.2 10886.1 10894.9 628.4 671.5 735.9 756.4 780.9 4781.7 5011.5 5051.3 5070.2 5119.6 80551.0 120717.4 123071.2 123710.0 125287.4 66317.7 66440.0 69542.0 90356.0 109639.0 61319.7 61445.0 61587.0 62321.0 98393.5 9661.7 9808.4 9822.0 9886.2 10035.6 39339.6 43949.6 55868.4 56267.4 56523.7 71363.0 83020.0 85789.6 87746.0 88497.0 12433.8 12590.9 12593.4 12920.7 12999.3 14188.9 14246.9 14294.6 14366.6 14403.3 13200.8 13562.9 13591.7 13799.3 13957.9 13288.0 13377.5 13411.5 13542.0 13649.9 12715.4 12752.3 13022.3 13327.3 13360.9 10951.0 10972.0 11083.9 11131.0 11161.9 10924.3 11107.2 11186.2 11324.7 11393.8 10:08:45 INFO - PROCESS | 9839 | -------- Summary: end -------- 10:08:45 INFO - PROCESS | 9839 | 10:08:45 INFO - TEST-INFO | 9839: exit 0 10:08:45 INFO - TEST-OK | dromaeo_css | took 1108971ms 10:08:45 INFO - TEST-START | kraken 10:08:45 INFO - operating with platform_type : linux_ 10:08:45 INFO - Initialising browser for kraken test... 10:08:45 INFO - TEST-INFO | started process 10084 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6pTc35/profile http://localhost:45378/getInfo.html) 10:08:50 INFO - PROCESS | 10084 | __metrics Screen width/height:1600/1200 10:08:50 INFO - PROCESS | 10084 | colorDepth:24 10:08:50 INFO - PROCESS | 10084 | Browser inner width/height: 1024/697 10:08:50 INFO - PROCESS | 10084 | __metrics 10:08:50 ERROR - PROCESS | 10084 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 10:08:51 INFO - TEST-INFO | 10084: exit 0 10:08:51 INFO - Browser initialized. 10:08:51 INFO - Running cycle 1/1 for kraken test... 10:08:51 INFO - TEST-INFO | started process 10214 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6pTc35/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:09:03 INFO - PROCESS | 10214 | RSS: Main: 155303936 10:09:03 INFO - PROCESS | 10214 | 10:09:05 INFO - PROCESS | 10214 | Cycle 1(1): loaded http://localhost:45378/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45378/tests/kraken/driver.html?testName=audio-beat-detection) 10:09:06 INFO - PROCESS | 10214 | RSS: Main: 160772096 10:09:06 INFO - PROCESS | 10214 | 10:09:09 INFO - PROCESS | 10214 | Cycle 1(1): loaded http://localhost:45378/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45378/tests/kraken/driver.html?testName=audio-dft) 10:09:09 INFO - PROCESS | 10214 | RSS: Main: 160481280 10:09:09 INFO - PROCESS | 10214 | 10:09:12 INFO - PROCESS | 10214 | Cycle 1(1): loaded http://localhost:45378/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45378/tests/kraken/driver.html?testName=audio-fft) 10:09:13 INFO - PROCESS | 10214 | RSS: Main: 161243136 10:09:13 INFO - PROCESS | 10214 | 10:09:15 INFO - PROCESS | 10214 | Cycle 1(1): loaded http://localhost:45378/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45378/tests/kraken/driver.html?testName=audio-oscillator) 10:09:16 INFO - PROCESS | 10214 | RSS: Main: 161165312 10:09:16 INFO - PROCESS | 10214 | 10:09:18 INFO - PROCESS | 10214 | Cycle 1(1): loaded http://localhost:45378/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45378/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:09:18 INFO - PROCESS | 10214 | RSS: Main: 161034240 10:09:18 INFO - PROCESS | 10214 | 10:09:21 INFO - PROCESS | 10214 | Cycle 1(1): loaded http://localhost:45378/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45378/tests/kraken/driver.html?testName=imaging-darkroom) 10:09:22 INFO - PROCESS | 10214 | RSS: Main: 160542720 10:09:22 INFO - PROCESS | 10214 | 10:09:26 INFO - PROCESS | 10214 | Cycle 1(1): loaded http://localhost:45378/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45378/tests/kraken/driver.html?testName=imaging-desaturate) 10:09:26 INFO - PROCESS | 10214 | RSS: Main: 157450240 10:09:26 INFO - PROCESS | 10214 | 10:09:29 INFO - PROCESS | 10214 | Cycle 1(1): loaded http://localhost:45378/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45378/tests/kraken/driver.html?testName=json-parse-financial) 10:09:30 INFO - PROCESS | 10214 | RSS: Main: 159100928 10:09:30 INFO - PROCESS | 10214 | 10:09:31 INFO - PROCESS | 10214 | Cycle 1(1): loaded http://localhost:45378/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45378/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:09:32 INFO - PROCESS | 10214 | RSS: Main: 159100928 10:09:32 INFO - PROCESS | 10214 | 10:09:34 INFO - PROCESS | 10214 | Cycle 1(1): loaded http://localhost:45378/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45378/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:09:34 INFO - PROCESS | 10214 | RSS: Main: 159330304 10:09:34 INFO - PROCESS | 10214 | 10:09:36 INFO - PROCESS | 10214 | Cycle 1(1): loaded http://localhost:45378/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45378/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:09:37 INFO - PROCESS | 10214 | RSS: Main: 159830016 10:09:37 INFO - PROCESS | 10214 | 10:09:39 INFO - PROCESS | 10214 | Cycle 1(1): loaded http://localhost:45378/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45378/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:09:40 INFO - PROCESS | 10214 | RSS: Main: 159940608 10:09:40 INFO - PROCESS | 10214 | 10:09:43 INFO - PROCESS | 10214 | Cycle 1(1): loaded http://localhost:45378/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45378/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:09:43 INFO - PROCESS | 10214 | RSS: Main: 159641600 10:09:43 INFO - PROCESS | 10214 | 10:09:45 INFO - PROCESS | 10214 | Cycle 1(1): loaded http://localhost:45378/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45378/tests/kraken/driver.html?testName=ai-astar) 10:09:45 INFO - PROCESS | 10214 | RSS: Main: 160415744 10:09:45 INFO - PROCESS | 10214 | 10:09:45 INFO - PROCESS | 10214 | __start_tp_report 10:09:45 INFO - PROCESS | 10214 | _x_x_mozilla_page_load 10:09:45 INFO - PROCESS | 10214 | _x_x_mozilla_page_load_details 10:09:45 INFO - PROCESS | 10214 | |i|pagename|runs| 10:09:45 INFO - PROCESS | 10214 | |0;ai-astar;112;105;113;112;111;111;111;112;111;110 10:09:45 INFO - PROCESS | 10214 | |1;audio-beat-detection;161;126;163;178;124;150;155;125;187;133 10:09:45 INFO - PROCESS | 10214 | |2;audio-dft;164;163;162;161;161;163;163;161;162;162 10:09:45 INFO - PROCESS | 10214 | |3;audio-fft;75;76;76;181;75;77;74;76;162;78 10:09:45 INFO - PROCESS | 10214 | |4;audio-oscillator;84;84;160;84;85;84;139;84;85;138 10:09:45 INFO - PROCESS | 10214 | |5;imaging-gaussian-blur;119;118;117;118;117;117;118;118;117;117 10:09:45 INFO - PROCESS | 10214 | |6;imaging-darkroom;146;148;147;146;148;147;148;147;148;151 10:09:45 INFO - PROCESS | 10214 | |7;imaging-desaturate;95;97;95;97;95;95;95;96;96;96 10:09:45 INFO - PROCESS | 10214 | |8;json-parse-financial;53;52;52;51;52;52;51;51;51;52 10:09:45 INFO - PROCESS | 10214 | |9;json-stringify-tinderbox;60;65;60;61;60;60;59;61;60;60 10:09:45 INFO - PROCESS | 10214 | |10;stanford-crypto-aes;75;77;76;79;78;79;79;77;106;82 10:09:45 INFO - PROCESS | 10214 | |11;stanford-crypto-ccm;128;130;122;135;126;128;135;120;128;125 10:09:45 INFO - PROCESS | 10214 | |12;stanford-crypto-pbkdf2;153;157;155;158;152;161;155;155;157;153 10:09:45 INFO - PROCESS | 10214 | |13;stanford-crypto-sha256-iterative;63;65;60;62;62;62;63;64;61;62 10:09:45 INFO - PROCESS | 10214 | __end_tp_report 10:09:45 INFO - PROCESS | 10214 | __start_cc_report 10:09:45 INFO - PROCESS | 10214 | _x_x_mozilla_cycle_collect,913 10:09:45 INFO - PROCESS | 10214 | __end_cc_report 10:09:45 INFO - PROCESS | 10214 | __startTimestamp1468343385703__endTimestamp 10:09:45 INFO - PROCESS | 10214 | 10:09:45 INFO - PROCESS | 10214 | ------- Summary: start ------- 10:09:45 INFO - PROCESS | 10214 | Number of tests: 14 10:09:45 INFO - PROCESS | 10214 | 10:09:45 INFO - PROCESS | 10214 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.50 stddev:2.20 (2.0%) stddev-sans-first:2.29 10:09:45 INFO - PROCESS | 10214 | Values: 112.0 105.0 113.0 112.0 111.0 111.0 111.0 112.0 111.0 110.0 10:09:45 INFO - PROCESS | 10214 | 10:09:45 INFO - PROCESS | 10214 | [#1] audio-beat-detection Cycles:10 Average:150.20 Median:158.00 stddev:22.69 (14.4%) stddev-sans-first:23.73 10:09:45 INFO - PROCESS | 10214 | Values: 161.0 126.0 163.0 178.0 124.0 150.0 155.0 125.0 187.0 133.0 10:09:45 INFO - PROCESS | 10214 | 10:09:45 INFO - PROCESS | 10214 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.50 stddev:1.03 (0.6%) stddev-sans-first:0.87 10:09:45 INFO - PROCESS | 10214 | Values: 164.0 163.0 162.0 161.0 161.0 163.0 163.0 161.0 162.0 162.0 10:09:45 INFO - PROCESS | 10214 | 10:09:45 INFO - PROCESS | 10214 | [#3] audio-fft Cycles:10 Average:95.00 Median:76.00 stddev:40.58 (53.4%) stddev-sans-first:42.39 10:09:45 INFO - PROCESS | 10214 | Values: 75.0 76.0 76.0 181.0 75.0 77.0 74.0 76.0 162.0 78.0 10:09:45 INFO - PROCESS | 10214 | 10:09:45 INFO - PROCESS | 10214 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:84.00 stddev:30.23 (36.0%) stddev-sans-first:31.29 10:09:45 INFO - PROCESS | 10214 | Values: 84.0 84.0 160.0 84.0 85.0 84.0 139.0 84.0 85.0 138.0 10:09:45 INFO - PROCESS | 10214 | 10:09:45 INFO - PROCESS | 10214 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.53 10:09:45 INFO - PROCESS | 10214 | Values: 119.0 118.0 117.0 118.0 117.0 117.0 118.0 118.0 117.0 117.0 10:09:45 INFO - PROCESS | 10214 | 10:09:45 INFO - PROCESS | 10214 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:1.43 (1.0%) stddev-sans-first:1.39 10:09:45 INFO - PROCESS | 10214 | Values: 146.0 148.0 147.0 146.0 148.0 147.0 148.0 147.0 148.0 151.0 10:09:45 INFO - PROCESS | 10214 | 10:09:45 INFO - PROCESS | 10214 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 10:09:45 INFO - PROCESS | 10214 | Values: 95.0 97.0 95.0 97.0 95.0 95.0 95.0 96.0 96.0 96.0 10:09:45 INFO - PROCESS | 10214 | 10:09:45 INFO - PROCESS | 10214 | [#8] json-parse-financial Cycles:10 Average:51.70 Median:52.00 stddev:0.67 (1.3%) stddev-sans-first:0.53 10:09:45 INFO - PROCESS | 10214 | Values: 53.0 52.0 52.0 51.0 52.0 52.0 51.0 51.0 51.0 52.0 10:09:45 INFO - PROCESS | 10214 | 10:09:45 INFO - PROCESS | 10214 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:60.00 stddev:1.65 (2.7%) stddev-sans-first:1.73 10:09:45 INFO - PROCESS | 10214 | Values: 60.0 65.0 60.0 61.0 60.0 60.0 59.0 61.0 60.0 60.0 10:09:45 INFO - PROCESS | 10214 | 10:09:45 INFO - PROCESS | 10214 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:78.50 stddev:9.07 (11.5%) stddev-sans-first:9.37 10:09:45 INFO - PROCESS | 10214 | Values: 75.0 77.0 76.0 79.0 78.0 79.0 79.0 77.0 106.0 82.0 10:09:45 INFO - PROCESS | 10214 | 10:09:45 INFO - PROCESS | 10214 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:128.00 stddev:4.88 (3.8%) stddev-sans-first:5.17 10:09:45 INFO - PROCESS | 10214 | Values: 128.0 130.0 122.0 135.0 126.0 128.0 135.0 120.0 128.0 125.0 10:09:45 INFO - PROCESS | 10214 | 10:09:45 INFO - PROCESS | 10214 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.60 Median:156.00 stddev:2.72 (1.7%) stddev-sans-first:2.71 10:09:45 INFO - PROCESS | 10214 | Values: 153.0 157.0 155.0 158.0 152.0 161.0 155.0 155.0 157.0 153.0 10:09:45 INFO - PROCESS | 10214 | 10:09:45 INFO - PROCESS | 10214 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:62.50 stddev:1.43 (2.3%) stddev-sans-first:1.50 10:09:45 INFO - PROCESS | 10214 | Values: 63.0 65.0 60.0 62.0 62.0 62.0 63.0 64.0 61.0 62.0 10:09:45 INFO - PROCESS | 10214 | -------- Summary: end -------- 10:09:45 INFO - PROCESS | 10214 | 10:09:46 INFO - TEST-INFO | 10214: exit 0 10:09:46 INFO - TEST-OK | kraken | took 60839ms 10:09:46 INFO - SUITE-END | took 1169s 10:09:46 INFO - Completed test suite (00:19:30) 10:09:46 INFO - javascript benchmark 10:09:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7573.983763441769, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3329.200991761977, 3359.143418428301, 3379.7803142795733, 3379.9831000844993, 3400.0479865637612, 5504.889902201953, 5517.393086760453, 5522.751476183571, 5530.806421775239, 5582.8325150245455, 5546.750396232169, 5593.133064375018, 5602.579806514507, 5611.270534830466, 5677.318721753385, 5055.823046193384, 5108.20822772469, 5182.481751824825, 5196.281816005748, 5200.219967004941, 5037.5718063964605, 5042.722650254234, 5086.92369614456, 5205.063088644042, 5217.191335343028, 5021.6986980781085, 5046.949530504685, 5094.898102037957, 5106.310648062501, 5110.795568177268, 5058.544730974211, 5092.490750924915, 5094.79620815167, 5100.0, 5127.717975511346, 4891.364122664067, 4976.726280054596, 5016.197408414672, 5052.46949070346, 5073.670211436245, 5381.354237491487, 5426.104692725696, 5472.151816468454, 5473.233747275384, 5488.56091512678, 5962.07587823888, 5980.55145864062, 5990.071538911432, 6003.609765365237, 6007.369226231226, 5860.736266868002, 5947.672877991708, 6055.939440605582, 6069.271687397496, 6078.149059131725, 5596.916046259309, 5633.549316054747, 5640.915386269209, 5647.830565083054, 5668.801591944262, 6114.602550834182, 6118.5716999810475, 6130.141780150782, 6136.386361363828, 6136.447719705248, 5626.043572592587, 5865.266841644794, 5884.6469211847425, 5888.028475301613, 5903.3801450847905, 6038.275406951107, 6038.758449661965, 6042.395760423922, 6054.0, 6084.939150608438, 5906.527477801766, 5948.375420580864, 6006.849828754229, 6009.188759517497, 6033.637981721111, 5707.942920570824, 5916.3787802281, 5928.703564821742, 5935.406459354116, 5992.34084250732, 4572.51988541205, 4596.655250856199, 4612.169809434334, 4613.5386461354265, 4635.791389387486, 4119.732217405919, 4133.648639865645, 4134.524529679125, 4155.646770024521, 4163.854265100767, 5525.806596769175, 5683.943160568341, 5696.401877802771, 5737.512311453574, 5775.27809023872, 5980.73086711099, 6032.819015429544, 6052.273727152769, 6114.419130182626, 6126.724297406628, 5640.351359593699, 5756.136579513023, 5864.354920958691, 5867.882642347129, 5870.236869206976, 5121.359830021247, 5132.640715149978, 5158.767855446514, 5158.793648254103, 5198.92201616976, 6211.627302361872, 6242.438180563771, 6252.781152659635, 6263.530235232284, 6293.465055470337, 5970.611910225822, 5978.461938425563, 5989.401059893976, 5989.730462129215, 6024.397560244116, 6086.269647642312, 6115.483736156635, 6139.96930015365, 6153.5692501526255, 6237.28271248794, 5804.535637148933, 5845.064789633639, 5857.677827719516, 5860.941390586039, 5868.002439585195, 5835.183074369676, 5923.111533270044, 5942.58401911862, 5957.672328022, 5970.492508136857, 5720.656760594377, 5721.628094173865, 5792.7103644818435, 5802.245708058094, 5805.8548536286935, 5729.455701708331, 5786.623869448473, 5800.187973683772, 5823.621464604787, 5830.300363956352, 5650.604457688087, 5715.828525144252, 5722.599418040863, 5732.398098199796, 5740.598158128891, 5861.9706901465215, 5903.26209223847, 5944.821655350346, 5958.285005799332, 5962.940370596239, 5773.16289138081, 5796.971015144897, 5800.738966746591, 5803.129530570448, 5806.912896306474], "value": 5521.953593673991, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.1371368372703, 639.9264084630267, 647.6437959122482, 648.5330561995363, 657.7500549791082, 45453.318200227026, 46486.53513464864, 46525.30212046822, 46583.0, 50733.49266507343, 49251.75374123133, 49514.50485495144, 49709.25436118452, 49843.25235121476, 49849.50150498503, 8789.989151247608, 8876.201141897229, 8901.955490222539, 8902.243309318716, 8930.598123084477, 9038.593263303168, 9039.909600903973, 9078.500682462462, 9096.044915283866, 9110.27117830572, 9055.230305424047, 9081.95459022704, 9105.226055785233, 9120.543972801366, 9131.0412406697, 9099.0, 9130.771730706752, 9143.451392916446, 9166.495842728647, 9167.862482062708, 9037.593308301142, 9093.818123637557, 9099.363044586882, 9105.681301154427, 9112.271018318519, 45829.0, 45934.0, 46042.30936535955, 46087.76956115198, 46242.07515849698, 3819.312523745725, 3888.7083468739675, 4394.318880573516, 4423.093265880487, 4459.799309031101, 33946.83026584876, 34091.0, 34134.829325853214, 34297.48553771695, 35607.0, 4442.378067070613, 4474.82100715971, 4509.030558429953, 4564.406627138451, 4590.150822097922, 380043.0, 380044.0, 380365.0, 382808.0859595712, 383812.0, 37244.25511489755, 61304.0, 61737.38262617406, 61809.69095154495, 61816.0, 38156.0, 39844.402333965016, 40183.0, 40405.79797101054, 40417.79791101025, 15185.696286074217, 15210.619734506727, 15661.138637375054, 15750.448734294245, 15762.921185394, 13407.731845363038, 13630.386632601556, 13802.964777641717, 13804.792928106086, 13839.930800345934, 9006.459612423276, 9014.278857691368, 9106.362554621113, 9106.544672766335, 9171.954140229256, 3501.7898926064518, 3507.824608769551, 3571.4642803579673, 3576.8748093816594, 3577.5170352002665, 1083.7344850511674, 1088.450332582041, 1135.330155208431, 1172.7654469106042, 1224.1920332580455, 32722.67277327244, 33324.83337583297, 33924.1518962023, 33979.32041359208, 34098.48852267218, 1105.9447027648584, 1133.345315838868, 1163.4764356039816, 1237.9133460657667, 1274.5284244829472, 17142.742858857127, 17165.485035448957, 17248.82751172472, 17414.477565672798, 17648.823511764716, 608600.0, 629886.0, 634096.0, 635992.0, 1025430.0, 61846.38153618496, 69744.0, 70151.0, 70203.0, 70270.0, 1491.9030263032869, 1523.8552337527917, 1537.4388348252808, 1542.845715428448, 1553.068159104551, 33832.3233535323, 34062.829685851415, 34371.31257374889, 34574.65425345714, 34646.65353346434, 57515.0, 57973.0, 58044.0, 58287.70856145862, 58449.70775146097, 521971.0, 527006.0, 528230.0, 530518.0, 531020.0, 48339.27491087566, 48438.0, 48632.51367486421, 48837.51162488329, 49069.2639610399, 52861.47138528565, 53629.7318513405, 53841.19238211351, 53961.73019135036, 54690.0, 44818.551814482744, 45299.32051019171, 45692.54307457016, 46308.30537542007, 46375.76812115918, 44498.555014450736, 44641.33038004497, 45039.324410134526, 46149.769251154874, 46313.0, 44948.325775114055, 45497.61622455564, 45602.77198614118, 45919.0, 46008.769956151344, 39645.60354396534, 39688.80155599204, 39898.800505997286, 40232.79883600563, 40552.391714123725, 30542.10217497244, 30605.540916886708, 30631.846840766546, 31078.844605776827, 31282.0], "value": 20838.93581911506, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.1579157476622, 423.18114448542053, 427.60446586907113, 428.5286185196284, 443.35270505062607, 18749.156287967042, 19867.20531178753, 20393.286234981777, 21363.57272854542, 21378.57242855142, 19706.310279140234, 19900.0, 20663.896680516576, 20727.896360518178, 20855.165793368247, 5637.718114094289, 5826.184334193216, 5869.8239052828485, 5878.794242201524, 5889.1755154278435, 5632.746526406321, 5736.196932429463, 5742.885142297151, 5830.0, 5845.912311315313, 5768.336641286242, 5782.45066718661, 5784.1902133701315, 5806.332271788756, 5810.622309549887, 5658.43415658435, 5752.971235143818, 5788.102844059156, 5789.189513468118, 5832.2418085649015, 5254.185601231815, 5254.868628284324, 5255.080360936859, 5269.499397557226, 5287.524122828964, 23391.298261052194, 23947.40131496709, 24384.634230486557, 24418.755812441825, 24651.0, 2582.7029891562333, 2826.3075546491036, 2840.3751174741524, 2869.540873460257, 2896.4641541314923, 10018.89981100187, 10475.633352832614, 10477.738056548571, 14869.107853528823, 15790.447334343358, 2021.4744166516812, 2023.2412845183057, 2030.6649402848511, 2043.4176259765895, 2095.800898914616, 87178.56410717906, 87909.56045219733, 89596.55201723949, 89892.10107898903, 91527.0, 11643.76712465746, 11693.532258709556, 11898.940505297418, 11915.76168476643, 12069.27584344942, 16608.25262863174, 16827.663446730996, 16865.91567042157, 16867.409640662518, 16877.578060548585, 8784.912150878537, 8813.162749538784, 8911.910880891237, 8928.776780580407, 9037.909620903838, 8616.870746938801, 8631.525266110424, 8645.481271123752, 8655.956720216358, 8725.476471411608, 5020.698758074527, 5063.620228482879, 5069.188929771219, 5125.923111153335, 5127.179651255781, 2021.7371741673783, 2080.8127268545904, 2135.1993002624017, 2138.860974036683, 2173.500094978164, 964.5804075227298, 1013.5591017907234, 1052.2055847834836, 1092.819684752023, 1153.2503872482785, 19544.609107817763, 19582.412527624194, 19762.11070501831, 20029.799702002794, 20307.695384569244, 1057.370864335719, 1073.8496610474383, 1093.4314156638504, 1095.6767753512734, 1127.7575321305958, 11127.610533631447, 11250.943745281222, 11320.886791132149, 11344.0, 11392.544298227978, 489600.0, 493317.0, 502327.0, 504069.0, 507817.0, 96715.51642241744, 100099.49950250347, 100184.49907750415, 101314.49342753239, 102626.0, 1058.0636137018794, 1064.531606093332, 1118.983215251772, 1150.1259043127116, 1150.7180740718577, 17257.74113388275, 17620.647587048443, 17659.646807064044, 17993.460196194133, 17996.820031799514, 40596.79701601473, 41453.0, 41903.79048104862, 41985.16029679451, 43617.345739813296, 59941.40058599358, 61354.69322653358, 61529.077063844976, 61598.0, 61635.0, 7889.4871833332945, 7906.52560846328, 8421.95789021051, 8712.869306960527, 9172.862407064033, 13070.673233168867, 13416.1279516835, 13669.726605468033, 13699.657508562366, 13921.79117313221, 12043.638690839289, 12285.57000504978, 12338.0, 12724.681882953, 12845.165064270792, 12141.210821296587, 12141.575044873387, 12308.076894232789, 12690.746185076432, 12845.743085138432, 12279.508819647113, 12309.44607492647, 12326.383680816103, 12408.441620126936, 12414.131010829517, 8344.123866993878, 8536.487810731376, 8589.312854971713, 8625.309975202093, 8708.085651006553, 11930.284182949052, 12374.319412432402, 12384.0, 12476.563320283747, 12639.304838233986], "value": 9744.694636878807, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1575.5115914066637, 1616.3211451190502, 1814.1382843149506, 1893.9810601893985, 1894.5642502224496, 9349.672761453341, 9685.225181985443, 9948.104670579647, 10094.09153176214, 10138.695839124819, 9836.360636558618, 9911.504424778768, 9961.501924903761, 9966.601335946554, 10205.438700871468, 2513.22090152053, 2536.708278547963, 2545.338212064858, 2550.41340491687, 2556.923292301234, 2480.3303108160785, 2513.0952856971567, 2517.848929064262, 2524.5960646296594, 2527.936801579966, 2466.2971053249826, 2476.9009239630395, 2486.0925762096886, 2493.2644869763462, 2500.6999160100722, 2447.045652195654, 2451.570975079363, 2456.9631455528183, 2492.476579918219, 2499.9250022499355, 2406.2420337593603, 2421.878906054708, 2421.9152329668555, 2442.7312995570474, 2527.431327951215, 9694.709158725249, 9819.852702209473, 9836.409815411098, 9849.113579777855, 9868.358556693793, 5730.885382292373, 5831.096180092092, 5840.912386314166, 5854.7072646367515, 5863.941360586382, 3596.0, 3650.507181530486, 3753.3244016077097, 3790.4124860646643, 3818.102745854722, 1152.3316476443642, 1158.4960542164101, 1167.5096459487036, 1177.3171560494893, 1195.1394995603152, 13795.2412617306, 13846.169229846242, 13907.304634768221, 13912.58262252134, 13943.790843137362, 4745.881352966135, 4841.9031619367415, 4892.412910450697, 4952.276248063551, 4979.651424400329, 10956.890431095746, 10964.122870170368, 10993.670189894316, 11010.174236932262, 11011.61459348919, 5618.410066942994, 5685.857853553612, 5687.544996400278, 5724.398938111522, 5725.5133313667975, 4434.623057040188, 4904.043711476228, 5038.345015148007, 5048.217526283432, 5331.306930099062, 4206.3690446432665, 4207.116505533811, 4211.915761684749, 4223.21870453967, 4223.746575205498, 1236.1223531292883, 1254.1221145198397, 1262.059765474709, 1278.622806272152, 1288.0275392079109, 988.9159421449258, 1020.1532727836027, 1024.5799222318813, 1038.3717850700368, 1048.124815778818, 6085.847853803691, 6156.5998210116195, 6187.443130118311, 6234.719437625317, 6237.875242495124, 478.4450037955954, 480.2603989855653, 480.86295405809176, 482.15141351222104, 500.36453703795974, 4120.320147175742, 4121.381792731115, 4129.050318426779, 4159.313713237282, 4182.832686692498, 11873.762524749456, 12288.938555307166, 12379.257244565355, 12382.380880955916, 12389.566365177176, 12139.210951288314, 12189.939050304693, 12281.263124212575, 12289.815652765215, 12296.139270250997, 8578.142185781497, 8899.955500222457, 8924.8661270081, 9178.357514973888, 9181.816363672822, 6221.4089661482085, 6393.808185754435, 6421.486281097407, 6477.740890364333, 6485.740570377132, 11160.88839111631, 11263.042641375574, 11381.886181138083, 11443.713907152387, 11484.425778710864, 11207.327560346404, 11448.0, 11666.416679166177, 11719.179657423898, 11867.347295898464, 7741.0, 7942.166072562529, 8089.271965523131, 8456.069832318317, 8644.78388040304, 9072.0, 9101.954490227507, 9121.407108537924, 9139.58871850755, 9158.450492970444, 7805.492642978188, 7997.680092796223, 8038.356931445353, 8046.476978996347, 8400.915990840012, 7871.173526779606, 7905.723299684483, 8019.318357939641, 8080.919190808252, 8147.674093036212, 7386.519876208029, 7428.777136685908, 7510.737124200627, 7566.924330756842, 7583.203763604963, 5055.393352797688, 5059.5952323814745, 5123.257127716534, 5128.512791284822, 5147.3308469898675, 5298.257506280136, 5401.86495337604, 5411.918821217606, 5445.945540544702, 5514.145307477347], "value": 4891.276022338238, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.1647935591038, 364.9251903359811, 364.97992610406436, 374.31873989339397, 376.5707093912938, 5610.270664813579, 5698.6865722385255, 5756.942430575698, 5824.271966004249, 5826.9999999999945, 5709.457601527859, 5713.771449142039, 5723.481668066048, 5728.942710572893, 5740.942590574093, 4426.557344265564, 4441.822327106928, 4478.305862591304, 4501.077279157765, 4510.594046535811, 4420.005498762785, 4496.6627502937245, 4510.210713125206, 4514.52597477265, 4523.208438523262, 4420.8673739787855, 4467.597916187542, 4468.932966005513, 4473.396091527635, 4485.237509623372, 4442.311441726538, 4455.955440445587, 4460.754658493782, 4466.665000124987, 4475.597196252353, 3974.4038394240806, 3987.7407968481957, 3993.1414745829497, 4014.2573623879675, 4062.5124985001694, 5454.91817622736, 5465.890682186334, 5476.0, 5476.808311709111, 5485.753141108659, 5115.590752739772, 5159.896802063975, 5179.669148883017, 5208.583313334924, 5212.582993360522, 5822.321732003284, 6008.699565021731, 6010.429009244115, 6053.0, 6090.5736598438125, 4323.610875021232, 4348.260795664744, 4366.257736184824, 4439.156560253541, 4445.355423463612, 6129.957907155795, 6259.7496100156395, 6277.372262773732, 6307.684615769239, 6367.140436041122, 4335.956640433618, 4485.820567177341, 4493.483249426358, 4493.955060449353, 4501.954980450219, 4548.931766023512, 4562.794674239667, 4583.770811459413, 4606.792694328763, 4616.3537104805355, 5185.7407129644125, 5188.948110518922, 5227.895442091137, 5244.5279924806955, 5258.447862974409, 5880.0297950838485, 5935.40645935403, 5997.670128142907, 6048.939510604838, 6070.028795392716, 1536.5467187179809, 1552.767084937246, 1559.50095969291, 1560.141921942927, 1567.5656774051843, 975.3465178330536, 978.9559469823876, 994.7363948553639, 1002.3384566186282, 1010.5856598794459, 5220.947790522122, 5221.503957124143, 5225.451327610622, 5242.715534694024, 5244.187150991603, 5502.477264659851, 5548.8082207527805, 5571.554275657938, 5606.635568688022, 5624.493795558419, 4881.9023619528125, 5226.686398816083, 5256.342957130359, 5263.236830659533, 5368.436314187033, 2893.363460038788, 2902.288939209865, 2960.7335339819087, 2976.5088760354733, 2985.805922615023, 5671.72386213107, 5714.200011998323, 5766.711664416763, 5805.448482394166, 5825.271841019872, 5894.410558944071, 6348.77779277723, 6357.4914006879335, 6362.681865906686, 6363.7772677956045, 6428.682120165448, 6455.61266324022, 6492.415682588589, 6498.707558159894, 6511.576747511492, 5985.6408615483215, 6168.660723660242, 6195.349488303844, 6209.8201341744925, 6212.316645168938, 6120.846978825387, 6139.785107521216, 6163.599366041193, 6174.475169610454, 6219.689015549295, 6116.66358350295, 6420.775272865428, 6466.902996454963, 6490.772822951174, 6554.2462616797775, 4368.2355587772645, 4383.904023994001, 4433.357163211252, 4452.398926144929, 4464.17412778637, 6082.300535438304, 6117.510599151969, 6368.968155159195, 6371.808845734636, 6421.775237866652, 5982.312034116132, 5987.31145918225, 6001.2498437695285, 6006.0, 6031.728572214173, 5899.528037756883, 5987.700614969322, 6008.399160084132, 6011.609245399035, 6034.788782392595, 5703.230063941315, 5958.314793798769, 6015.187949626919, 6027.2164618601055, 6062.545309101747, 6083.8174854754425, 6109.633421994695, 6116.3272040076445, 6130.785422510191, 6137.140800287874, 5603.663780173202, 5918.461200087922, 5927.733252003584, 5941.910871336847, 6004.268058033672], "value": 4548.697577548929, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [735.6321839080459, 744.7393412305694, 778.0080397493196, 792.635387721648, 792.7582087463321, 13108.60674179775, 13396.263205523692, 13559.050866439353, 13604.387802548885, 13787.931060344697, 15299.84700152998, 15544.68910621787, 15664.216789160553, 15692.215389230521, 15703.37186512541, 710.1088134391357, 855.8331125430543, 858.1247127929523, 879.2965627498008, 879.4459490520995, 877.4384393987852, 880.6741505642921, 883.902770695223, 885.3227281129941, 886.6409104312731, 685.1298850459913, 687.6321168175027, 689.8068540808556, 691.4502970138752, 700.898369736388, 687.8074139241021, 689.5586824432368, 692.2765709833236, 692.8164036530324, 697.5012865800977, 524.779592571121, 529.986750331241, 531.9920201196985, 533.8291746641077, 537.1298496435799, 15611.375544978187, 15673.608159795982, 15704.214789260492, 15714.44999425026, 15744.0, 15745.291461884128, 15944.601384965352, 16050.839491605167, 16256.674866502723, 16305.0, 12813.807792883114, 13088.411021504055, 13211.933940330333, 13229.140105893086, 13365.933170334183, 3978.403239514067, 3992.6207010333974, 4094.4063110849056, 4099.159672267178, 4215.22018426589, 82762.58618706868, 83280.0, 83633.0, 84114.57942710309, 84669.0, 11622.0, 11766.764664706658, 11812.40937953099, 11897.881021189678, 12130.150889437831, 20135.697964530544, 20594.691079633816, 20834.47913802137, 20873.26943556968, 20905.163793448395, 9185.908140918638, 9228.538573071453, 9297.30270229722, 9472.194863436685, 9510.476923769122, 4736.052789442126, 4792.95207047925, 4894.26586012094, 4946.579540739005, 4956.727379994135, 3885.825137868803, 4012.27778999777, 4013.2776100302226, 4014.417909403179, 4016.0562267867026, 693.9271376505495, 698.4935921457005, 705.544923524324, 706.6113637499354, 707.3351050013074, 628.9496840252768, 720.7405334079727, 755.3466251692356, 783.9255270749384, 803.7869964459423, 10615.256932014685, 10817.621383251548, 10850.240483166102, 10886.129109671207, 10894.891051089546, 628.3653509954887, 671.4628297362091, 735.9328972989188, 756.4402342266793, 780.8594452998401, 4781.713097214179, 5011.5489605935645, 5051.292819005343, 5070.163423035158, 5119.564836988823, 80551.0, 120717.39641301737, 123071.23736465657, 123710.0, 125287.3735631316, 66317.66841165764, 66440.0, 69542.0, 90356.0, 109639.0, 61319.693401532706, 61445.0, 61587.0, 62321.0, 98393.50803246081, 9661.71014869555, 9808.411495310304, 9822.0, 9886.209103271865, 10035.648752293635, 39339.60660393359, 43949.56050439455, 55868.44131558632, 56267.43732562622, 56523.71738141283, 71363.0, 83020.0, 85789.57105214434, 87746.0, 88497.0, 12433.813492797795, 12590.937045314715, 12593.370331483573, 12920.741585168433, 12999.285039322927, 14188.929055354658, 14246.857531424554, 14294.571162865132, 14366.56900292993, 14403.279836008367, 13200.801987969997, 13562.93218533901, 13591.660208494866, 13799.310034498034, 13957.860421396063, 13288.0, 13377.53178638743, 13411.463541458623, 13542.0, 13649.931750341184, 12715.364231788188, 12752.298623575793, 13022.348882556023, 13327.333633318489, 13360.93319533396, 10951.0, 10972.0, 11083.944580277048, 11131.0, 11161.88838111641, 10924.344539327665, 11107.166962477684, 11186.161037922351, 11324.716882078013, 11393.801444565934], "value": 7565.8684776831515, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1520.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 113.0, 112.0, 111.0, 111.0, 111.0, 112.0, 111.0, 110.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 126.0, 163.0, 178.0, 124.0, 150.0, 155.0, 125.0, 187.0, 133.0], "value": 150.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 161.0, 161.0, 163.0, 163.0, 161.0, 162.0, 162.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 181.0, 75.0, 77.0, 74.0, 76.0, 162.0, 78.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 160.0, 84.0, 85.0, 84.0, 139.0, 84.0, 85.0, 138.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 146.0, 148.0, 147.0, 148.0, 147.0, 148.0, 151.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 97.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 52.0, 51.0, 52.0, 52.0, 51.0, 51.0, 51.0, 52.0], "value": 51.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 65.0, 60.0, 61.0, 60.0, 60.0, 59.0, 61.0, 60.0, 60.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 79.0, 78.0, 79.0, 79.0, 77.0, 106.0, 82.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 130.0, 122.0, 135.0, 126.0, 128.0, 135.0, 120.0, 128.0, 125.0], "value": 127.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 157.0, 155.0, 158.0, 152.0, 161.0, 155.0, 155.0, 157.0, 153.0], "value": 155.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 60.0, 62.0, 62.0, 62.0, 63.0, 64.0, 61.0, 62.0], "value": 62.4, "unit": "score"}]}]} 10:09:46 INFO - Return code: 0 10:09:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:09:47 ERROR - # TBPL SUCCESS # 10:09:47 INFO - Running post-action listener: _resource_record_post_action 10:09:47 INFO - ##### 10:09:47 INFO - ##### Finished run-tests step (success) 10:09:47 INFO - ##### 10:09:47 INFO - Running post-run listener: _resource_record_post_run 10:09:47 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 290816; Write bytes: 507793408; Read time: 44; Write time: 371196 10:09:47 INFO - TinderboxPrint: CPU usage
13.4% 10:09:47 INFO - TinderboxPrint: I/O read bytes / time
290,816 / 44 10:09:47 INFO - TinderboxPrint: I/O write bytes / time
507,793,408 / 371,196 10:09:47 INFO - TinderboxPrint: CPU idle
8,203.3 (86.6%) 10:09:47 INFO - TinderboxPrint: CPU user
1,212.8 (12.8%) 10:09:47 INFO - TinderboxPrint: Swap in / out
0 / 0 10:09:47 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 259371008; Read time: 0; Write time: 240780 10:09:47 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 266240; Write bytes: 248422400; Read time: 32; Write time: 130416 10:09:47 INFO - Running post-run listener: _upload_blobber_files 10:09:47 INFO - Blob upload gear active. 10:09:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:09:47 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 10:09:47 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'] 10:09:47 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 10:09:48 INFO - (blobuploader) - INFO - Open directory for files ... 10:09:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:09:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:09:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:09:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:09:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:09:48 INFO - (blobuploader) - INFO - Done attempting. 10:09:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:09:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:09:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:09:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:09:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:09:49 INFO - (blobuploader) - INFO - Done attempting. 10:09:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:09:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:09:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:09:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:09:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:09:53 INFO - (blobuploader) - INFO - Done attempting. 10:09:53 INFO - (blobuploader) - INFO - Iteration through files over. 10:09:53 INFO - Return code: 0 10:09:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:09:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:09:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f0dae55a33c3929efde521ab1105edd9b199cba471338ac11a7e72036e18c6f8be2472b8d42700665fba2aac45aa765bb1a61523ec7e6977476fb24717695f30", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/426270f0df4fabc166b9021ab0645bad3b4b80cceee600ff76fffb1c3ee32aa82bdb72ca932194bef80f1f236c77a1c149f2ebaafccb3bae39772707491121d7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7d3ddaad675966c67f75f5afe6dc9011657c0e22a98d3049c8a3f566a57f25839634b22f1acd77e16ea7685d5804cd91463c9fdb28f637eab62d3c6aa996c53"} 10:09:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:09:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:09:53 INFO - Contents: 10:09:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f0dae55a33c3929efde521ab1105edd9b199cba471338ac11a7e72036e18c6f8be2472b8d42700665fba2aac45aa765bb1a61523ec7e6977476fb24717695f30", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/426270f0df4fabc166b9021ab0645bad3b4b80cceee600ff76fffb1c3ee32aa82bdb72ca932194bef80f1f236c77a1c149f2ebaafccb3bae39772707491121d7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7d3ddaad675966c67f75f5afe6dc9011657c0e22a98d3049c8a3f566a57f25839634b22f1acd77e16ea7685d5804cd91463c9fdb28f637eab62d3c6aa996c53"} 10:09:53 INFO - Running post-run listener: copy_logs_to_upload_dir 10:09:53 INFO - Copying logs to upload dir... 10:09:53 INFO - mkdir: /builds/slave/test/build/upload/logs 10:09:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.607372 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-12 10:09:53.818778) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 10:09:53.822545) ========= 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=0333a256a5e4f052382dd180000001b1-1468342162.464043-1874228474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f0dae55a33c3929efde521ab1105edd9b199cba471338ac11a7e72036e18c6f8be2472b8d42700665fba2aac45aa765bb1a61523ec7e6977476fb24717695f30", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/426270f0df4fabc166b9021ab0645bad3b4b80cceee600ff76fffb1c3ee32aa82bdb72ca932194bef80f1f236c77a1c149f2ebaafccb3bae39772707491121d7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7d3ddaad675966c67f75f5afe6dc9011657c0e22a98d3049c8a3f566a57f25839634b22f1acd77e16ea7685d5804cd91463c9fdb28f637eab62d3c6aa996c53"} build_url:https://queue.taskcluster.net/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011348 build_url: 'https://queue.taskcluster.net/v1/task/JorDqRcGSoCma2xKG7GneQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f0dae55a33c3929efde521ab1105edd9b199cba471338ac11a7e72036e18c6f8be2472b8d42700665fba2aac45aa765bb1a61523ec7e6977476fb24717695f30", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/426270f0df4fabc166b9021ab0645bad3b4b80cceee600ff76fffb1c3ee32aa82bdb72ca932194bef80f1f236c77a1c149f2ebaafccb3bae39772707491121d7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7d3ddaad675966c67f75f5afe6dc9011657c0e22a98d3049c8a3f566a57f25839634b22f1acd77e16ea7685d5804cd91463c9fdb28f637eab62d3c6aa996c53"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 10:09:53.848097) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 10:09:53.848459) ========= 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=0333a256a5e4f052382dd180000001b1-1468342162.464043-1874228474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004433 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 10:09:53.932518) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 10:09:53.932912) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 10:09:53.933261) ========= ========= Total master_lag: 0.17 =========