builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-022 starttime: 1466624365.47 results: success (0) buildid: 20160622100424 builduid: 6a8a9cc3a1894bcfacedef17ed39722c revision: b463de85df02512c96e9e19087522c34b08fcd08 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 12:39:25.469569) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 12:39:25.469980) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 12:39:25.470263) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 12:39:25.530183) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 12:39:25.530448) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1466621671.815597-1120144089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 12:39:25-- 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% 298K=0.04s 2016-06-22 12:39:25 (298 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.208788 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 12:39:25.783220) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 12:39:25.783562) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1466621671.815597-1120144089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.108747 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 12:39:25.907464) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 12:39:25.908271) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b463de85df02512c96e9e19087522c34b08fcd08 --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 b463de85df02512c96e9e19087522c34b08fcd08 --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=9c43b49b387003dc8f5b4e5c000001c4-1466621671.815597-1120144089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 12:39:25,924 truncating revision to first 12 chars 2016-06-22 12:39:25,924 Setting DEBUG logging. 2016-06-22 12:39:25,924 attempt 1/10 2016-06-22 12:39:25,924 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b463de85df02?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 12:39:26,226 unpacking tar archive at: mozilla-aurora-b463de85df02/testing/mozharness/ program finished with exit code 0 elapsedTime=0.632931 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 12:39:26.558187) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 12:39:26.559011) ========= script_repo_revision: b463de85df02512c96e9e19087522c34b08fcd08 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 12:39:26.559987) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 12:39:26.560751) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 12:39:26.576036) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-06-22 12:39:26.576577) ========= /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=9c43b49b387003dc8f5b4e5c000001c4-1466621671.815597-1120144089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:39:26 INFO - MultiFileLogger online at 20160622 12:39:26 in /builds/slave/test 12:39:26 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 12:39:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:39:26 INFO - {'append_to_log': False, 12:39:26 INFO - 'base_work_dir': '/builds/slave/test', 12:39:26 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:39:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:39:26 INFO - 'branch': 'Mozilla-Aurora', 12:39:26 INFO - 'buildbot_json_path': 'buildprops.json', 12:39:26 INFO - 'config_files': ('talos/linux_config.py',), 12:39:26 INFO - 'default_actions': ('clobber', 12:39:26 INFO - 'read-buildbot-config', 12:39:26 INFO - 'download-and-extract', 12:39:26 INFO - 'populate-webroot', 12:39:26 INFO - 'create-virtualenv', 12:39:26 INFO - 'install', 12:39:26 INFO - 'run-tests'), 12:39:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:39:26 INFO - 'download_minidump_stackwalk': True, 12:39:26 INFO - 'download_symbols': 'ondemand', 12:39:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:39:26 INFO - 'tooltool.py': '/tools/tooltool.py', 12:39:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:39:26 INFO - '/tools/misc-python/virtualenv.py')}, 12:39:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:39:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:39:26 INFO - 'installer_path': 'installer.exe', 12:39:26 INFO - 'log_level': 'info', 12:39:26 INFO - 'log_name': 'talos', 12:39:26 INFO - 'log_to_console': True, 12:39:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:39:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:39:26 INFO - 'opt_config_files': (), 12:39:26 INFO - 'pip_index': False, 12:39:26 INFO - 'sps_profile': False, 12:39:26 INFO - 'sps_profile_interval': 0, 12:39:26 INFO - 'suite': 'dromaeojs-e10s', 12:39:26 INFO - 'system_bits': '32', 12:39:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:39:26 INFO - 'title': 'talos-linux64-ix-022', 12:39:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:39:26 INFO - 'use_talos_json': True, 12:39:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:39:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:39:26 INFO - 'work_dir': 'build'} 12:39:26 INFO - ##### 12:39:26 INFO - ##### Running clobber step. 12:39:26 INFO - ##### 12:39:26 INFO - Running pre-action listener: _resource_record_pre_action 12:39:26 INFO - Running main action method: clobber 12:39:26 INFO - rmtree: /builds/slave/test/build 12:39:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:39:28 INFO - Running post-action listener: _resource_record_post_action 12:39:28 INFO - ##### 12:39:28 INFO - ##### Finished clobber step (success) 12:39:28 INFO - ##### 12:39:28 INFO - ##### 12:39:28 INFO - ##### Running read-buildbot-config step. 12:39:28 INFO - ##### 12:39:28 INFO - Running pre-action listener: _resource_record_pre_action 12:39:28 INFO - Running main action method: read_buildbot_config 12:39:28 INFO - Using buildbot properties: 12:39:28 INFO - { 12:39:28 INFO - "project": "", 12:39:28 INFO - "product": "firefox", 12:39:28 INFO - "script_repo_revision": "production", 12:39:28 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 12:39:28 INFO - "repository": "", 12:39:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 12:39:28 INFO - "buildid": "20160622100424", 12:39:28 INFO - "pgo_build": "True", 12:39:28 INFO - "basedir": "/builds/slave/test", 12:39:28 INFO - "buildnumber": 362, 12:39:28 INFO - "slavename": "talos-linux64-ix-022", 12:39:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:39:28 INFO - "platform": "ubuntu64_hw", 12:39:28 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 12:39:28 INFO - "branch": "mozilla-aurora", 12:39:28 INFO - "repo_path": "releases/mozilla-aurora", 12:39:28 INFO - "revision": "b463de85df02512c96e9e19087522c34b08fcd08", 12:39:28 INFO - "stage_platform": "linux64-pgo", 12:39:28 INFO - "builduid": "6a8a9cc3a1894bcfacedef17ed39722c", 12:39:28 INFO - "slavebuilddir": "test" 12:39:28 INFO - } 12:39:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 12:39:28 INFO - Running post-action listener: _resource_record_post_action 12:39:28 INFO - ##### 12:39:28 INFO - ##### Finished read-buildbot-config step (success) 12:39:28 INFO - ##### 12:39:28 INFO - ##### 12:39:28 INFO - ##### Running download-and-extract step. 12:39:28 INFO - ##### 12:39:28 INFO - Running pre-action listener: _resource_record_pre_action 12:39:28 INFO - Running main action method: download_and_extract 12:39:28 INFO - mkdir: /builds/slave/test/build/tests 12:39: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')]} 12:39:28 INFO - https://queue.taskcluster.net/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:39:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 12:39:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 12:39:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/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 12:39:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/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 12:39:35 INFO - Downloaded 1361 bytes. 12:39:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 12:39:35 INFO - Using the following test package requirements: 12:39:35 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 12:39:35 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:39:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 12:39:35 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:39:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 12:39:35 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:39:35 INFO - u'jsshell-linux-x86_64.zip'], 12:39:35 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:39:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 12:39:35 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 12:39:35 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:39:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 12:39:35 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:39:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 12:39:35 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:39:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 12:39:35 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:39:35 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 12:39:35 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:39:35 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')]} 12:39:35 INFO - https://queue.taskcluster.net/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:39:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 12:39:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 12:39:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/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 12:39:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/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 12:39:43 INFO - Downloaded 24473137 bytes. 12:39:43 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'] 12:39:43 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 12:39:44 INFO - Return code: 0 12:39:44 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 12:39:44 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')]} 12:39:44 INFO - https://queue.taskcluster.net/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:39:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 12:39:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 12:39:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/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 12:39:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/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 12:39:46 INFO - Downloaded 24473137 bytes. 12:39:46 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'] 12:39:46 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 12:39:47 INFO - Return code: 0 12:39:47 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')]} 12:39:47 INFO - https://queue.taskcluster.net/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:39:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 12:39:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 12:39:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/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 12:39:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/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 12:39:49 INFO - Downloaded 10833369 bytes. 12:39:49 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'] 12:39:49 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 12:39:49 INFO - Return code: 0 12:39:49 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')]} 12:39:49 INFO - https://queue.taskcluster.net/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:39:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 12:39:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 12:39:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/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 12:39:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/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 12:39:50 INFO - Downloaded 63617112 bytes. 12:39:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 12:39:50 INFO - mkdir: /builds/slave/test/properties 12:39:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:39:50 INFO - Writing to file /builds/slave/test/properties/build_url 12:39:50 INFO - Contents: 12:39:50 INFO - build_url:https://queue.taskcluster.net/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 12:39:51 INFO - Running post-action listener: _resource_record_post_action 12:39:51 INFO - Running post-action listener: set_extra_try_arguments 12:39:51 INFO - ##### 12:39:51 INFO - ##### Finished download-and-extract step (success) 12:39:51 INFO - ##### 12:39:51 INFO - ##### 12:39:51 INFO - ##### Running populate-webroot step. 12:39:51 INFO - ##### 12:39:51 INFO - Running pre-action listener: _resource_record_pre_action 12:39:51 INFO - Running main action method: populate_webroot 12:39:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:39:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:39:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:39:51 INFO - '--tppagecycles', 12:39:51 INFO - '7'], 12:39:51 INFO - 'tests': ['tsvgm']}}, 12:39:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:39:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:39:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:39:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:39:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:39:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:39:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:51 INFO - 'talos_options': ['--disable-e10s'], 12:39:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:39:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:39:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:51 INFO - 'talos_options': ['--disable-e10s'], 12:39:51 INFO - 'tests': ['damp', 'tps']}, 12:39:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:51 INFO - 'tests': ['damp', 'tps']}, 12:39:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:39:51 INFO - 'tests': ['dromaeo_dom']}, 12:39:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:39:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:39:51 INFO - 'tests': ['a11yr', 12:39:51 INFO - 'ts_paint', 12:39:51 INFO - 'tpaint', 12:39:51 INFO - 'sessionrestore', 12:39:51 INFO - 'sessionrestore_no_auto_restore', 12:39:51 INFO - 'tabpaint']}, 12:39:51 INFO - 'other-e10s': {'tests': ['a11yr', 12:39:51 INFO - 'ts_paint', 12:39:51 INFO - 'tpaint', 12:39:51 INFO - 'sessionrestore', 12:39:51 INFO - 'sessionrestore_no_auto_restore', 12:39:51 INFO - 'tabpaint']}, 12:39:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:39:51 INFO - 'ts_paint', 12:39:51 INFO - 'tpaint', 12:39:51 INFO - 'sessionrestore', 12:39:51 INFO - 'sessionrestore_no_auto_restore', 12:39:51 INFO - 'tabpaint']}, 12:39:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:39:51 INFO - 'ts_paint', 12:39:51 INFO - 'tpaint', 12:39:51 INFO - 'sessionrestore', 12:39:51 INFO - 'sessionrestore_no_auto_restore', 12:39:51 INFO - 'tabpaint']}, 12:39:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:39:51 INFO - 'tests': ['a11yr', 12:39:51 INFO - 'ts_paint', 12:39:51 INFO - 'tpaint', 12:39:51 INFO - 'sessionrestore', 12:39:51 INFO - 'sessionrestore_no_auto_restore', 12:39:51 INFO - 'tabpaint']}, 12:39:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:39:51 INFO - 'tests': ['a11yr', 12:39:51 INFO - 'ts_paint', 12:39:51 INFO - 'tpaint', 12:39:51 INFO - 'sessionrestore', 12:39:51 INFO - 'sessionrestore_no_auto_restore', 12:39:51 INFO - 'tabpaint']}, 12:39:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:39:51 INFO - 'tests': ['tsvgx', 12:39:51 INFO - 'tsvgr_opacity', 12:39:51 INFO - 'tart', 12:39:51 INFO - 'tscrollx', 12:39:51 INFO - 'cart']}, 12:39:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:39:51 INFO - 'tsvgr_opacity', 12:39:51 INFO - 'tart', 12:39:51 INFO - 'tscrollx', 12:39:51 INFO - 'cart']}, 12:39:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:51 INFO - 'talos_options': ['--disable-e10s'], 12:39:51 INFO - 'tests': ['tp5o']}, 12:39:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:51 INFO - 'tests': ['tp5o']}, 12:39:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:51 INFO - 'talos_options': ['--disable-e10s', 12:39:51 INFO - '--xperf_path', 12:39:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:39:51 INFO - 'tests': ['tp5n']}, 12:39:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:51 INFO - 'talos_options': ['--xperf_path', 12:39:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:39:51 INFO - 'tests': ['tp5n']}}, 12:39:51 INFO - 'talos.zip': {'path': '', 12:39:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:39:51 INFO - Running post-action listener: _resource_record_post_action 12:39:51 INFO - ##### 12:39:51 INFO - ##### Finished populate-webroot step (success) 12:39:51 INFO - ##### 12:39:51 INFO - ##### 12:39:51 INFO - ##### Running create-virtualenv step. 12:39:51 INFO - ##### 12:39:51 INFO - Running pre-action listener: _resource_record_pre_action 12:39:51 INFO - Running main action method: create_virtualenv 12:39:51 INFO - Creating virtualenv /builds/slave/test/build/venv 12:39:51 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 12:39:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:39:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:39:51 INFO - Using real prefix '/usr' 12:39:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:39:52 INFO - Installing distribute.............................................................................................................................................................................................done. 12:39:54 INFO - Installing pip.................done. 12:39:54 INFO - Return code: 0 12:39:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:39:54 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')]} 12:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:54 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')]} 12:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:54 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 0x7f1c6e268f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x189c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192e2e0>, '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 0x189a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x189a5d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466621671.815597-1120144089', '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 12:39:54 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 12:39:54 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 12:39:54 INFO - Using env: {'DISPLAY': ':0', 12:39:54 INFO - 'HOME': '/home/cltbld', 12:39:54 INFO - 'LANG': 'en_US.UTF-8', 12:39:54 INFO - 'LANGUAGE': 'en_US:en', 12:39:54 INFO - 'LOGNAME': 'cltbld', 12:39:54 INFO - 'MAIL': '/var/mail/cltbld', 12:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:54 INFO - 'MOZ_NO_REMOTE': '1', 12:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:54 INFO - 'NO_EM_RESTART': '1', 12:39:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:54 INFO - 'PWD': '/builds/slave/test', 12:39:54 INFO - 'SHELL': '/bin/bash', 12:39:54 INFO - 'SHLVL': '1', 12:39:54 INFO - 'TERM': 'linux', 12:39:54 INFO - 'TMOUT': '86400', 12:39:54 INFO - 'USER': 'cltbld', 12:39:54 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466621671.815597-1120144089', 12:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:54 INFO - '_': '/tools/buildbot/bin/python'} 12:39:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:55 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 12:39:55 INFO - Cleaning up... 12:39:55 INFO - Return code: 0 12:39:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:39: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')]} 12:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39: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')]} 12:39:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:55 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 0x7f1c6e268f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x189c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192e2e0>, '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 0x189a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x189a5d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466621671.815597-1120144089', '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 12:39:55 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 12:39:55 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 12:39:55 INFO - Using env: {'DISPLAY': ':0', 12:39:55 INFO - 'HOME': '/home/cltbld', 12:39:55 INFO - 'LANG': 'en_US.UTF-8', 12:39:55 INFO - 'LANGUAGE': 'en_US:en', 12:39:55 INFO - 'LOGNAME': 'cltbld', 12:39:55 INFO - 'MAIL': '/var/mail/cltbld', 12:39:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:55 INFO - 'MOZ_NO_REMOTE': '1', 12:39:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:55 INFO - 'NO_EM_RESTART': '1', 12:39:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:55 INFO - 'PWD': '/builds/slave/test', 12:39:55 INFO - 'SHELL': '/bin/bash', 12:39:55 INFO - 'SHLVL': '1', 12:39:55 INFO - 'TERM': 'linux', 12:39:55 INFO - 'TMOUT': '86400', 12:39:55 INFO - 'USER': 'cltbld', 12:39:55 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466621671.815597-1120144089', 12:39:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:55 INFO - '_': '/tools/buildbot/bin/python'} 12:39:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:55 INFO - Downloading/unpacking psutil>=3.1.1 12:39:55 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 12:39:55 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 12:39:55 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 12:39:55 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 12:39:55 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 12:39:55 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 12:39:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:39:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:39:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:39:57 INFO - Installing collected packages: psutil 12:39:57 INFO - Running setup.py install for psutil 12:39:57 INFO - building 'psutil._psutil_linux' extension 12:39:57 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 12:39:59 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 12:39:59 INFO - building 'psutil._psutil_posix' extension 12:39:59 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 12:39:59 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 12:39:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:39:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:39:59 INFO - Successfully installed psutil 12:39:59 INFO - Cleaning up... 12:39:59 INFO - Return code: 0 12:39:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:39:59 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')]} 12:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:59 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')]} 12:39:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:59 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 0x7f1c6e268f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x189c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192e2e0>, '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 0x189a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x189a5d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466621671.815597-1120144089', '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 12:39:59 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 12:39:59 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 12:39:59 INFO - Using env: {'DISPLAY': ':0', 12:39:59 INFO - 'HOME': '/home/cltbld', 12:39:59 INFO - 'LANG': 'en_US.UTF-8', 12:39:59 INFO - 'LANGUAGE': 'en_US:en', 12:39:59 INFO - 'LOGNAME': 'cltbld', 12:39:59 INFO - 'MAIL': '/var/mail/cltbld', 12:39:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:59 INFO - 'MOZ_NO_REMOTE': '1', 12:39:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:59 INFO - 'NO_EM_RESTART': '1', 12:39:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:59 INFO - 'PWD': '/builds/slave/test', 12:39:59 INFO - 'SHELL': '/bin/bash', 12:39:59 INFO - 'SHLVL': '1', 12:39:59 INFO - 'TERM': 'linux', 12:39:59 INFO - 'TMOUT': '86400', 12:39:59 INFO - 'USER': 'cltbld', 12:39:59 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466621671.815597-1120144089', 12:39:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:59 INFO - '_': '/tools/buildbot/bin/python'} 12:40:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:40:00 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 12:40:00 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 12:40:00 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 12:40:00 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 12:40:00 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 12:40:00 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 12:40:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:40:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:40:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:40:02 INFO - Installing collected packages: mozsystemmonitor 12:40:02 INFO - Running setup.py install for mozsystemmonitor 12:40:02 INFO - Successfully installed mozsystemmonitor 12:40:02 INFO - Cleaning up... 12:40:02 INFO - Return code: 0 12:40:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:40:02 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')]} 12:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:02 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')]} 12:40:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:02 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 0x7f1c6e268f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x189c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192e2e0>, '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 0x189a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x189a5d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466621671.815597-1120144089', '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 12:40:02 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 12:40:02 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 12:40:02 INFO - Using env: {'DISPLAY': ':0', 12:40:02 INFO - 'HOME': '/home/cltbld', 12:40:02 INFO - 'LANG': 'en_US.UTF-8', 12:40:02 INFO - 'LANGUAGE': 'en_US:en', 12:40:02 INFO - 'LOGNAME': 'cltbld', 12:40:02 INFO - 'MAIL': '/var/mail/cltbld', 12:40:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:02 INFO - 'MOZ_NO_REMOTE': '1', 12:40:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:02 INFO - 'NO_EM_RESTART': '1', 12:40:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:02 INFO - 'PWD': '/builds/slave/test', 12:40:02 INFO - 'SHELL': '/bin/bash', 12:40:02 INFO - 'SHLVL': '1', 12:40:02 INFO - 'TERM': 'linux', 12:40:02 INFO - 'TMOUT': '86400', 12:40:02 INFO - 'USER': 'cltbld', 12:40:02 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466621671.815597-1120144089', 12:40:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:02 INFO - '_': '/tools/buildbot/bin/python'} 12:40:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:02 INFO - Downloading/unpacking jsonschema==2.5.1 12:40:02 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 12:40:02 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 12:40:02 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 12:40:02 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 12:40:02 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 12:40:02 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 12:40:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:40:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:40:04 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 12:40:04 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 12:40:04 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 12:40:04 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 12:40:04 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 12:40:04 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 12:40:04 INFO - Downloading functools32-3.2.3-2.tar.gz 12:40:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:40:04 INFO - warning: no files found matching '*.txt' 12:40:04 INFO - no previously-included directories found matching 'build' 12:40:04 INFO - no previously-included directories found matching 'dist' 12:40:04 INFO - no previously-included directories found matching '.git*' 12:40:04 INFO - Installing collected packages: jsonschema, functools32 12:40:04 INFO - Running setup.py install for functools32 12:40:04 INFO - warning: no files found matching '*.txt' 12:40:04 INFO - no previously-included directories found matching 'build' 12:40:04 INFO - no previously-included directories found matching 'dist' 12:40:04 INFO - no previously-included directories found matching '.git*' 12:40:04 INFO - Successfully installed jsonschema functools32 12:40:04 INFO - Cleaning up... 12:40:04 INFO - Return code: 0 12:40:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:40:04 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')]} 12:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:04 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')]} 12:40:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:04 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 0x7f1c6e268f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x189c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192e2e0>, '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 0x189a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x189a5d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466621671.815597-1120144089', '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 12:40:04 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 12:40:04 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 12:40:04 INFO - Using env: {'DISPLAY': ':0', 12:40:04 INFO - 'HOME': '/home/cltbld', 12:40:04 INFO - 'LANG': 'en_US.UTF-8', 12:40:04 INFO - 'LANGUAGE': 'en_US:en', 12:40:04 INFO - 'LOGNAME': 'cltbld', 12:40:04 INFO - 'MAIL': '/var/mail/cltbld', 12:40:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:04 INFO - 'MOZ_NO_REMOTE': '1', 12:40:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:04 INFO - 'NO_EM_RESTART': '1', 12:40:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:04 INFO - 'PWD': '/builds/slave/test', 12:40:04 INFO - 'SHELL': '/bin/bash', 12:40:04 INFO - 'SHLVL': '1', 12:40:04 INFO - 'TERM': 'linux', 12:40:04 INFO - 'TMOUT': '86400', 12:40:04 INFO - 'USER': 'cltbld', 12:40:04 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466621671.815597-1120144089', 12:40:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:04 INFO - '_': '/tools/buildbot/bin/python'} 12:40:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:04 INFO - Downloading/unpacking blobuploader==1.2.4 12:40:04 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 12:40:04 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 12:40:04 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 12:40:04 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 12:40:04 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 12:40:04 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 12:40:06 INFO - Downloading blobuploader-1.2.4.tar.gz 12:40:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:40:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:40:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:07 INFO - Downloading docopt-0.6.1.tar.gz 12:40:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:40:07 INFO - Installing collected packages: blobuploader, requests, docopt 12:40:07 INFO - Running setup.py install for blobuploader 12:40:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:40:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:40:07 INFO - Running setup.py install for requests 12:40:08 INFO - Running setup.py install for docopt 12:40:08 INFO - Successfully installed blobuploader requests docopt 12:40:08 INFO - Cleaning up... 12:40:08 INFO - Return code: 0 12:40:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:40:08 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')]} 12:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:08 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')]} 12:40:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:08 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 0x7f1c6e268f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x189c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192e2e0>, '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 0x189a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x189a5d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466621671.815597-1120144089', '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 12:40:08 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 12:40:08 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 12:40:08 INFO - Using env: {'DISPLAY': ':0', 12:40:08 INFO - 'HOME': '/home/cltbld', 12:40:08 INFO - 'LANG': 'en_US.UTF-8', 12:40:08 INFO - 'LANGUAGE': 'en_US:en', 12:40:08 INFO - 'LOGNAME': 'cltbld', 12:40:08 INFO - 'MAIL': '/var/mail/cltbld', 12:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:08 INFO - 'MOZ_NO_REMOTE': '1', 12:40:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:08 INFO - 'NO_EM_RESTART': '1', 12:40:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:08 INFO - 'PWD': '/builds/slave/test', 12:40:08 INFO - 'SHELL': '/bin/bash', 12:40:08 INFO - 'SHLVL': '1', 12:40:08 INFO - 'TERM': 'linux', 12:40:08 INFO - 'TMOUT': '86400', 12:40:08 INFO - 'USER': 'cltbld', 12:40:08 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466621671.815597-1120144089', 12:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:08 INFO - '_': '/tools/buildbot/bin/python'} 12:40:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:40:08 INFO - Running setup.py (path:/tmp/pip-FjmwCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:40:08 INFO - Running setup.py (path:/tmp/pip-lerpOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:40:08 INFO - Running setup.py (path:/tmp/pip-DdKEA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:40:08 INFO - Running setup.py (path:/tmp/pip-6TW7LA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:40:08 INFO - Running setup.py (path:/tmp/pip-ADnBfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:40:08 INFO - Running setup.py (path:/tmp/pip-lLmxVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:40:08 INFO - Running setup.py (path:/tmp/pip-eR9NV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:40:09 INFO - Running setup.py (path:/tmp/pip-77152Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:40:09 INFO - Running setup.py (path:/tmp/pip-MSiYxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:40:09 INFO - Running setup.py (path:/tmp/pip-DA3whu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:40:09 INFO - Running setup.py (path:/tmp/pip-pRhwyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:40:09 INFO - Running setup.py (path:/tmp/pip-FNMi1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:40:09 INFO - Running setup.py (path:/tmp/pip-rddTHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:40:09 INFO - Running setup.py (path:/tmp/pip-bLhN8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:40:09 INFO - Running setup.py (path:/tmp/pip-JwkGhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:40:09 INFO - Running setup.py (path:/tmp/pip-he7sKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:40:09 INFO - Running setup.py (path:/tmp/pip-YRGmfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:40:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:40:09 INFO - Running setup.py install for manifestparser 12:40:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:40:09 INFO - Running setup.py install for mozcrash 12:40:09 INFO - Running setup.py install for mozdebug 12:40:10 INFO - Running setup.py install for mozdevice 12:40:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:40:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:40:10 INFO - Running setup.py install for mozfile 12:40:10 INFO - Running setup.py install for mozhttpd 12:40:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:40:10 INFO - Running setup.py install for mozinfo 12:40:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:40:10 INFO - Running setup.py install for mozInstall 12:40:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:40:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:40:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:40:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:40:10 INFO - Running setup.py install for mozleak 12:40:10 INFO - Running setup.py install for mozlog 12:40:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:40:10 INFO - Running setup.py install for moznetwork 12:40:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:40:10 INFO - Running setup.py install for mozprocess 12:40:11 INFO - Running setup.py install for mozprofile 12:40:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:40:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:40:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:40:11 INFO - Running setup.py install for mozrunner 12:40:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:40:11 INFO - Running setup.py install for mozscreenshot 12:40:11 INFO - Running setup.py install for moztest 12:40:11 INFO - Running setup.py install for mozversion 12:40:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:40:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:40:11 INFO - Cleaning up... 12:40:11 INFO - Return code: 0 12:40:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:40:11 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')]} 12:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:11 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')]} 12:40:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:11 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 0x7f1c6e268f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x189c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192e2e0>, '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 0x189a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x189a5d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466621671.815597-1120144089', '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 12:40:11 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 12:40:11 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 12:40:11 INFO - Using env: {'DISPLAY': ':0', 12:40:11 INFO - 'HOME': '/home/cltbld', 12:40:11 INFO - 'LANG': 'en_US.UTF-8', 12:40:11 INFO - 'LANGUAGE': 'en_US:en', 12:40:11 INFO - 'LOGNAME': 'cltbld', 12:40:11 INFO - 'MAIL': '/var/mail/cltbld', 12:40:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:11 INFO - 'MOZ_NO_REMOTE': '1', 12:40:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:11 INFO - 'NO_EM_RESTART': '1', 12:40:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:11 INFO - 'PWD': '/builds/slave/test', 12:40:11 INFO - 'SHELL': '/bin/bash', 12:40:11 INFO - 'SHLVL': '1', 12:40:11 INFO - 'TERM': 'linux', 12:40:11 INFO - 'TMOUT': '86400', 12:40:11 INFO - 'USER': 'cltbld', 12:40:11 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466621671.815597-1120144089', 12:40:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:11 INFO - '_': '/tools/buildbot/bin/python'} 12:40:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:40:11 INFO - Running setup.py (path:/tmp/pip-qxlCAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:40:11 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)) 12:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:40:11 INFO - Running setup.py (path:/tmp/pip-BKZ7a7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:40:11 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)) 12:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:40:11 INFO - Running setup.py (path:/tmp/pip-h9_O_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:40:12 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)) 12:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:40:12 INFO - Running setup.py (path:/tmp/pip-cBDNuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:40:12 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)) 12:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:40:12 INFO - Running setup.py (path:/tmp/pip-MqJOgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:40:12 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)) 12:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:40:12 INFO - Running setup.py (path:/tmp/pip-JHZbMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:40:12 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)) 12:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:40:12 INFO - Running setup.py (path:/tmp/pip-UDCqf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:40:12 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)) 12:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:40:12 INFO - Running setup.py (path:/tmp/pip-4lMSOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:40:12 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)) 12:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:40:12 INFO - Running setup.py (path:/tmp/pip-R11ZqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:40:12 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)) 12:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:40:12 INFO - Running setup.py (path:/tmp/pip-lgt4re-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:40:12 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)) 12:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:40:12 INFO - Running setup.py (path:/tmp/pip-ynIcOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:40:12 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)) 12:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:40:12 INFO - Running setup.py (path:/tmp/pip-mrGqhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 12:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:40:12 INFO - Running setup.py (path:/tmp/pip-wUUedW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:40:12 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)) 12:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:40:12 INFO - Running setup.py (path:/tmp/pip-ZfYsPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 12:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:40:12 INFO - Running setup.py (path:/tmp/pip-UKyGSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:40:12 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)) 12:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:40:12 INFO - Running setup.py (path:/tmp/pip-20VwUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:40:12 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)) 12:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:40:12 INFO - Running setup.py (path:/tmp/pip-dCis_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:40:13 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)) 12:40:13 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)) 12:40:13 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)) 12:40:13 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)) 12:40:13 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)) 12:40:13 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)) 12:40:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:14 INFO - Downloading blessings-1.6.tar.gz 12:40:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:40:15 INFO - Installing collected packages: blessings 12:40:15 INFO - Running setup.py install for blessings 12:40:15 INFO - Successfully installed blessings 12:40:15 INFO - Cleaning up... 12:40:15 INFO - Return code: 0 12:40:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:40:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:40:15 INFO - Reading from file tmpfile_stdout 12:40:15 INFO - Current package versions: 12:40:15 INFO - argparse == 1.2.1 12:40:15 INFO - blessings == 1.6 12:40:15 INFO - blobuploader == 1.2.4 12:40:15 INFO - docopt == 0.6.1 12:40:15 INFO - functools32 == 3.2.3-2 12:40:15 INFO - jsonschema == 2.5.1 12:40:15 INFO - manifestparser == 1.1 12:40:15 INFO - mozInstall == 1.12 12:40:15 INFO - mozcrash == 0.17 12:40:15 INFO - mozdebug == 0.1 12:40:15 INFO - mozdevice == 0.48 12:40:15 INFO - mozfile == 1.2 12:40:15 INFO - mozhttpd == 0.7 12:40:15 INFO - mozinfo == 0.9 12:40:15 INFO - mozleak == 0.1 12:40:15 INFO - mozlog == 3.2 12:40:15 INFO - moznetwork == 0.27 12:40:15 INFO - mozprocess == 0.22 12:40:15 INFO - mozprofile == 0.28 12:40:15 INFO - mozrunner == 6.11 12:40:15 INFO - mozscreenshot == 0.1 12:40:15 INFO - mozsystemmonitor == 0.3 12:40:15 INFO - moztest == 0.7 12:40:15 INFO - mozversion == 1.4 12:40:15 INFO - psutil == 3.1.1 12:40:15 INFO - requests == 1.2.3 12:40:15 INFO - wsgiref == 0.1.2 12:40:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:40: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')]} 12:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40: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')]} 12:40:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:15 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 0x7f1c6e268f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x189c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192e2e0>, '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 0x189a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x189a5d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466621671.815597-1120144089', '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 12:40:15 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 12:40:15 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 12:40:15 INFO - Using env: {'DISPLAY': ':0', 12:40:15 INFO - 'HOME': '/home/cltbld', 12:40:15 INFO - 'LANG': 'en_US.UTF-8', 12:40:15 INFO - 'LANGUAGE': 'en_US:en', 12:40:15 INFO - 'LOGNAME': 'cltbld', 12:40:15 INFO - 'MAIL': '/var/mail/cltbld', 12:40:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:15 INFO - 'MOZ_NO_REMOTE': '1', 12:40:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:15 INFO - 'NO_EM_RESTART': '1', 12:40:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:15 INFO - 'PWD': '/builds/slave/test', 12:40:15 INFO - 'SHELL': '/bin/bash', 12:40:15 INFO - 'SHLVL': '1', 12:40:15 INFO - 'TERM': 'linux', 12:40:15 INFO - 'TMOUT': '86400', 12:40:15 INFO - 'USER': 'cltbld', 12:40:15 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466621671.815597-1120144089', 12:40:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:15 INFO - '_': '/tools/buildbot/bin/python'} 12:40:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:15 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)) 12:40:15 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)) 12:40:15 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)) 12:40:15 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)) 12:40:15 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)) 12:40:15 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)) 12:40:15 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)) 12:40:15 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)) 12:40:15 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)) 12:40:15 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)) 12:40:15 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)) 12:40:15 INFO - Cleaning up... 12:40:15 INFO - Return code: 0 12:40:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:40: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')]} 12:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40: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')]} 12:40:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1c6e268f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x189c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192e2e0>, '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 0x189a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x189a5d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466621671.815597-1120144089', '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 12:40:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:40:15 INFO - Using env: {'DISPLAY': ':0', 12:40:15 INFO - 'HOME': '/home/cltbld', 12:40:15 INFO - 'LANG': 'en_US.UTF-8', 12:40:15 INFO - 'LANGUAGE': 'en_US:en', 12:40:15 INFO - 'LOGNAME': 'cltbld', 12:40:15 INFO - 'MAIL': '/var/mail/cltbld', 12:40:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:15 INFO - 'MOZ_NO_REMOTE': '1', 12:40:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:15 INFO - 'NO_EM_RESTART': '1', 12:40:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:15 INFO - 'PWD': '/builds/slave/test', 12:40:15 INFO - 'SHELL': '/bin/bash', 12:40:15 INFO - 'SHLVL': '1', 12:40:15 INFO - 'TERM': 'linux', 12:40:15 INFO - 'TMOUT': '86400', 12:40:15 INFO - 'USER': 'cltbld', 12:40:15 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466621671.815597-1120144089', 12:40:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:15 INFO - '_': '/tools/buildbot/bin/python'} 12:40:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:40:15 INFO - Cleaning up... 12:40:15 INFO - Return code: 0 12:40:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:40: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')]} 12:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40: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')]} 12:40:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1c6e268f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x189c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192e2e0>, '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 0x189a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x189a5d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466621671.815597-1120144089', '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 12:40:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 12:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:40:15 INFO - Using env: {'DISPLAY': ':0', 12:40:15 INFO - 'HOME': '/home/cltbld', 12:40:15 INFO - 'LANG': 'en_US.UTF-8', 12:40:15 INFO - 'LANGUAGE': 'en_US:en', 12:40:15 INFO - 'LOGNAME': 'cltbld', 12:40:15 INFO - 'MAIL': '/var/mail/cltbld', 12:40:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:15 INFO - 'MOZ_NO_REMOTE': '1', 12:40:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:15 INFO - 'NO_EM_RESTART': '1', 12:40:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:15 INFO - 'PWD': '/builds/slave/test', 12:40:15 INFO - 'SHELL': '/bin/bash', 12:40:15 INFO - 'SHLVL': '1', 12:40:15 INFO - 'TERM': 'linux', 12:40:15 INFO - 'TMOUT': '86400', 12:40:15 INFO - 'USER': 'cltbld', 12:40:15 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466621671.815597-1120144089', 12:40:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:15 INFO - '_': '/tools/buildbot/bin/python'} 12:40:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:16 INFO - Downloading/unpacking flake8 12:40:16 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 12:40:16 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 12:40:16 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 12:40:16 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 12:40:16 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 12:40:16 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 12:40:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:40:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:40:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:40:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:40:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:40:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:40:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:40:18 INFO - no previously-included directories found matching 'docs/_build' 12:40:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:40:18 INFO - Running setup.py install for pep8 12:40:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:40:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:40:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:40:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:40:18 INFO - no previously-included directories found matching 'docs/_build' 12:40:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:40:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:40:18 INFO - Cleaning up... 12:40:18 INFO - Return code: 0 12:40:18 INFO - Running post-action listener: _resource_record_post_action 12:40:18 INFO - Running post-action listener: _start_resource_monitoring 12:40:18 INFO - Starting resource monitoring. 12:40:18 INFO - ##### 12:40:18 INFO - ##### Finished create-virtualenv step (success) 12:40:18 INFO - ##### 12:40:18 INFO - ##### 12:40:18 INFO - ##### Running install step. 12:40:18 INFO - ##### 12:40:18 INFO - Running pre-action listener: _resource_record_pre_action 12:40:18 INFO - Running main action method: install 12:40:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:40:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:40:19 INFO - Reading from file tmpfile_stdout 12:40:19 INFO - Detecting whether we're running mozinstall >=1.0... 12:40:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:40:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:40:19 INFO - Reading from file tmpfile_stdout 12:40:19 INFO - Output received: 12:40:19 INFO - Usage: mozinstall [options] installer 12:40:19 INFO - Options: 12:40:19 INFO - -h, --help show this help message and exit 12:40:19 INFO - -d DEST, --destination=DEST 12:40:19 INFO - Directory to install application into. [default: 12:40:19 INFO - "/builds/slave/test"] 12:40:19 INFO - --app=APP Application being installed. [default: firefox] 12:40:19 INFO - mkdir: /builds/slave/test/build/application 12:40:19 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'] 12:40:19 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 12:40:35 INFO - Reading from file tmpfile_stdout 12:40:35 INFO - Output received: 12:40:35 INFO - /builds/slave/test/build/application/firefox/firefox 12:40:35 INFO - Running post-action listener: _resource_record_post_action 12:40:35 INFO - ##### 12:40:35 INFO - ##### Finished install step (success) 12:40:35 INFO - ##### 12:40:35 INFO - ##### 12:40:35 INFO - ##### Running run-tests step. 12:40:35 INFO - ##### 12:40:35 INFO - Running pre-action listener: _resource_record_pre_action 12:40:35 INFO - Running main action method: run_tests 12:40:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:40:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:40:35 INFO - Python 2.7.3 12:40:35 INFO - Return code: 0 12:40:35 INFO - grabbing minidump binary from tooltool 12:40:35 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')]} 12:40:35 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 0x192e2e0>, '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 0x189a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x189a5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:40:35 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 12:40:35 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 12:40:35 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 12:40:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:40:35 INFO - Return code: 0 12:40:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:40:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:40:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:40:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:40:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:40:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:40:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:40:36 INFO - Return code: 0 12:40:36 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/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 12:40:36 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/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 12:40:36 INFO - Using env: {'DISPLAY': ':0', 12:40:36 INFO - 'HOME': '/home/cltbld', 12:40:36 INFO - 'LANG': 'en_US.UTF-8', 12:40:36 INFO - 'LANGUAGE': 'en_US:en', 12:40:36 INFO - 'LOGNAME': 'cltbld', 12:40:36 INFO - 'MAIL': '/var/mail/cltbld', 12:40:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:40:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:40:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:36 INFO - 'MOZ_NO_REMOTE': '1', 12:40:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:40:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:36 INFO - 'NO_EM_RESTART': '1', 12:40:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:36 INFO - 'PWD': '/builds/slave/test', 12:40:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:40:36 INFO - 'SHELL': '/bin/bash', 12:40:36 INFO - 'SHLVL': '1', 12:40:36 INFO - 'TERM': 'linux', 12:40:36 INFO - 'TMOUT': '86400', 12:40:36 INFO - 'USER': 'cltbld', 12:40:36 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466621671.815597-1120144089', 12:40:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:36 INFO - '_': '/tools/buildbot/bin/python'} 12:40:36 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/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 12:40:36 INFO - mozversion application_buildid: 20160622100424 12:40:36 INFO - mozversion application_changeset: b463de85df02512c96e9e19087522c34b08fcd08 12:40:36 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:40:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:40:36 INFO - mozversion application_name: Firefox 12:40:36 INFO - mozversion application_remotingname: firefox-dev 12:40:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:40:36 INFO - mozversion application_vendor: Mozilla 12:40:36 INFO - mozversion application_version: 49.0a2 12:40:36 INFO - mozversion platform_buildid: 20160622100424 12:40:36 INFO - mozversion platform_changeset: b463de85df02512c96e9e19087522c34b08fcd08 12:40:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:40:36 INFO - mozversion platform_version: 49.0a2 12:40:36 INFO - using testdate: 1466624436 12:40:36 INFO - actual date: 1466624436 12:40:36 INFO - starting webserver on 'localhost:42394' 12:40:36 INFO - SUITE-START | Running 2 tests 12:40:36 INFO - TEST-START | dromaeo_css 12:40:36 INFO - operating with platform_type : linux_ 12:40:36 INFO - Initialising browser for dromaeo_css test... 12:40:36 INFO - TEST-INFO | started process 3352 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDuXufL/profile http://localhost:42394/getInfo.html) 12:40:43 INFO - PROCESS | 3352 | __metrics Screen width/height:1600/1200 12:40:43 INFO - PROCESS | 3352 | colorDepth:24 12:40:43 INFO - PROCESS | 3352 | Browser inner width/height: 1024/697 12:40:43 INFO - PROCESS | 3352 | __metrics 12:40:44 ERROR - PROCESS | 3352 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 12:40:44 INFO - TEST-INFO | 3352: exit 0 12:40:44 INFO - Browser initialized. 12:40:44 INFO - Running cycle 1/1 for dromaeo_css test... 12:40:44 INFO - TEST-INFO | started process 3485 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDuXufL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:40:56 INFO - PROCESS | 3485 | RSS: Main: 156618752 12:40:56 INFO - PROCESS | 3485 | 12:41:46 INFO - PROCESS | 3485 | 1466624506325 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] 12:43:54 INFO - PROCESS | 3485 | Cycle 1(1): loaded http://localhost:42394/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42394/tests/dromaeo/cssquery-ext.html) 12:43:55 INFO - PROCESS | 3485 | RSS: Main: 159436800 12:43:55 INFO - PROCESS | 3485 | 12:46:57 INFO - PROCESS | 3485 | Cycle 1(1): loaded http://localhost:42394/tests/dromaeo/cssquery-ext.html (next: http://localhost:42394/tests/dromaeo/cssquery-jquery.html) 12:46:57 INFO - PROCESS | 3485 | RSS: Main: 157425664 12:46:57 INFO - PROCESS | 3485 | 12:49:59 INFO - PROCESS | 3485 | Cycle 1(1): loaded http://localhost:42394/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42394/tests/dromaeo/cssquery-mootools.html) 12:50:00 INFO - PROCESS | 3485 | RSS: Main: 157237248 12:50:00 INFO - PROCESS | 3485 | 12:53:02 INFO - PROCESS | 3485 | Cycle 1(1): loaded http://localhost:42394/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42394/tests/dromaeo/cssquery-prototype.html) 12:53:02 INFO - PROCESS | 3485 | RSS: Main: 156413952 12:53:02 INFO - PROCESS | 3485 | 12:56:05 INFO - PROCESS | 3485 | Cycle 1(1): loaded http://localhost:42394/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42394/tests/dromaeo/cssquery-yui.html) 12:56:05 INFO - PROCESS | 3485 | RSS: Main: 159031296 12:56:05 INFO - PROCESS | 3485 | 12:59:07 INFO - PROCESS | 3485 | Cycle 1(1): loaded http://localhost:42394/tests/dromaeo/cssquery-yui.html (next: http://localhost:42394/tests/dromaeo/cssquery-dojo.html) 12:59:08 INFO - PROCESS | 3485 | RSS: Main: 159514624 12:59:08 INFO - PROCESS | 3485 | 12:59:08 INFO - PROCESS | 3485 | __start_tp_report 12:59:08 INFO - PROCESS | 3485 | _x_x_mozilla_page_load 12:59:08 INFO - PROCESS | 3485 | _x_x_mozilla_page_load_details 12:59:08 INFO - PROCESS | 3485 | |i|pagename|runs| 12:59:08 INFO - PROCESS | 3485 | |0;dojo.html;3345.5650765400496;3380.104272367823;3391.2200193955405;3400.353932752777;3420.880269190577;5643.435656434354;5656.943430565699;5751.971240143798;5760.337561180466;5767.1349297605275;5683.715814209283;5711.657300561958;5717.599768016241;5722.284714410699;5730.484256416921;5124.513171248744;5142.202958541413;5183.663061900983;5242.8689282767855;5264.763085661154;5193.246979188016;5197;5200.895982080356;5231.058409486291;5258.158694608864;5164.870878228036;5223;5259.105951988152;5264.763085661154;5304.20436934461;5326.414094449627;5327.200919862013;5327.280817089682;5330.706811125387;5330.946690533084;4943.480934501861;5104.744762761847;5211.895762084775;5223.973880130613;5271.42014378418;5556.777728890839;5581.246531718247;5608.383077861432;5644.915326270109;5662.886742265132;6133.202683651141;6141.078838174265;6149.907751383733;6160.8767824643255;6169.598976066586;6072.332043475214;6132.141360525201;6160.322364539942;6216;6217.471514921237;5707.74315155819;5718.34239062509;5729.1119876419225;5764.481196692276;5769.826905192851;6319.747210111636;6344.777932772423;6358.459530939829;6363.681815909186;6364.840878978062;5933.910991335133;5964.1650168976375;5978.730957106941;6025.457708806229;6072.301685306246;6080.209572755513;6097.908531372033;6105.603135796159;6115.1744514490865;6115.388461153849;5921.289445266596;6065.969670151621;6069.817905462844;6087.54343424245;6088.269407671108;6028.698565071729;6051.57638965277;6070.817875463743;6091.086337049478;6112.51099912006;4625.167469855458;4625.167469855458;4640.512746161672;4642.373279607277;4655.813767449332;4120.793960301973;4133.379993001074;4172.853950111731;4176.394422808676;4213;5619.4099619540175;5823.5923485355615;5915.467607915222;5962.821115366546;5963.224780778558;6132.263729246456;6192.628442293477;6196.3803619638575;6214.875702485925;6217.720202590895;5696.629719068247;5831.2127862738835;5923.437273459101;5928.318243402064;5963.075723262901;5238.842834714965;5280.366356037223;5283.5773138149625;5311.362636483646;5344.038073146793;6290.308066112724;6327.240731112296;6328.177336946167;6329.145565348619;6391.936080639227;5974.581779275409;6116.2140376365605;6125.846853828601;6128.472568454306;6159.5072394209255;6402.711877965409;6414.61512309263;6424.421802037839;6460.935390646221;6465.806025819233;6060.575784672606;6096;6116.082587611894;6124.0201567748945;6128.142060111677;6010.338862725184;6139.614800607318;6175.660338681416;6191.288001879841;6193.1329613855;6032.607880487754;6079.118228883798;6097.75608975636;6102.145699602148;6110.157901280617;6065.211522502046;6082.908756368746;6087.726052327567;6092.512598992159;6098.481629061579;5773.624714393551;5794.0439827428;5826.067829147316;5849.444302791228;5902.557308201816;5910.438508341701;5954.583179177589;5966.820995370146;5977.581569290108;6019.036954087325;5744.109663002241;5886.05823068307;5895;5900.527957763455;5909.91135132982 12:59:08 INFO - PROCESS | 3485 | |1;ext.html;587.8354060862957;639.5043841023204;644.5874640230253;654.110409842614;657.6251536624123;45275.77362113189;45990.54009459904;46918.53081469184;47023.29465058027;50104.74947625266;45764.313535297;46944.76527617357;46998.0600387992;47067.529324706746;47082.29376559346;8988.550572471366;9150.450972941644;9198.540072996324;9201.72394828153;9210.67762628308;8956.910430895672;9087.273018158532;9092.090790920922;9101.63593456261;9114.043025482328;9162.816743665122;9172.633094676205;9218.86171707425;9218.907810921872;9227.953860230724;9058.456492610432;9087.318451116193;9150;9163.129502697233;9178.770530736718;9014.143656352637;9040.095990400972;9104.044075372123;9105.408148470327;9108.22580080694;42754.35868461976;43060.354094688606;43389.34915976263;43411.78294108509;43485.78257108726;4042.8787136385954;4418.116376724636;4468.0840427712565;4528.43394575678;4586.793594288231;32448.513272300934;33299.334013319596;33674.49488257678;33770;34434.13914652129;4629.629629629621;4697.849026988376;4709.364235828188;4722.669413141081;4761.166795810719;298551;299974.99999999785;300058;300347;301015;53925.460745392826;60736.39263607396;61099.38900610937;61247.38752612417;61388.38611613916;39309;40262.79868600638;40294.39558406568;41776.58223417788;42101.15797684029;15990.36038558468;16070;16075.919620401823;16075.919620401823;16120;13460;13539.255340956342;13590.864091359157;13617.727645447036;13677.179369237878;20753.481162970744;20834.89582552108;20844.58310833775;20965.68551471729;21041.263555775473;7361.779146625609;7521.4734968551675;7567.810804729816;7661.118971318258;7688.692452301957;1009.2027298434155;1059.7933402986498;1114.225613198819;1161.0073387253944;1185.0815617896199;31867.681323186935;31981.360372792413;32057.358852822814;32066;32579;1145.9255148415327;1154.417019405195;1224.797908345131;1236.8144778283329;1271.1864406779669;16869.240884159997;17178.39875604348;17240.224189911485;17372.218250178772;17474.825251747574;412562;924156;1057956;1077227;1082562;64609.67695161588;65747;65874.34125658778;66143.66928165329;66173;1443.978340324896;1449.7680371140777;1452.0561634937376;1458.1761304862719;1487.6950225203807;31730.206744831565;33446.498302525;33716.66283337135;33777.3244535103;33886;55618.44381556295;56098.71950640221;56430.717846412146;56543.434565655465;56564.7171764155;512349;514945;516660;517193;519156;30912.227194320323;31222.21944451316;31476;31502.36995260128;31562.684373155975;50236.49763502318;50519.24221136759;51404.97190056103;51613.741931290104;52117.47882521278;42982;43265;43301.3504797422;43778;44109.33835992527;42116;42730.57269427266;42790.786046069574;42921.785391072845;44210;38265;42632.57367426286;43017.569824302605;43684.34473482964;43940.78029609832;36775.816120919226;37621.35680643691;37645.62354376421;38307.23385532218;38406.423903642026;28953.78587990732;29794.255143620714;29835.254118647208;29963.850180748956;30026.849865751406 12:59:08 INFO - PROCESS | 3485 | |2;jquery.html;439.0987026176654;440.4076517084524;441.384268944822;445.14309953339813;447.42282455632215;18806.52983675409;19356.51608709783;20093.598128037447;20156;20230.696539551882;18708.345207917726;19524.51188720283;19809.306674266405;19815.702764458543;20086.598268034668;5495.093309603911;5668.489835914766;5706.942930570683;5711;5711.600187986843;5690.57320700947;5849.268841394825;5915.142304365886;5958.702064896759;5996.550258730591;5853.531717462614;5991.101334799771;6002.519798416138;6025.246844144482;6215.782447614334;6166.475849552793;6228.688565571703;6240.719167637467;6242.687865606724;6251.937480625181;5732.99672557305;6011.909821352683;6016.909746353808;6022.518198544106;6044.788432404889;15193.696126077528;15269.083854968627;15278.15970121643;22285.108595656155;23982.28053158408;2375.10933399975;2500.862452565108;2525.9621105683427;2660.840349579031;2718.836869787819;10803.189760767895;10909.945450272699;11143.609973650884;11186.944065279702;11432.37121958292;2051.9589608207903;2097.318371529259;2108.609907167179;2133.0294715904224;2136.59404713104;84064;85499.57250213771;86053.56973215156;88063;90342;10647.787044259072;11477.081833453303;11861.169718119821;12075.698107547381;12219.205751626116;16737.414190503274;16995.49013529596;17047;17126.314947402214;17137.828621713874;8525.232729054414;8541.871871921927;8626.482411055356;8823.367676979778;8992.505412202392;8455.408121431563;8504.744857654281;8515.74452766418;8519.148085191431;8635.654573816977;5100.897982040338;5117.8464646060675;5191.506806853418;5201.245819356172;5259.474052594786;2092.591944570794;2098.979010209909;2116.5978464091772;2122.7240458740266;2158.589867925089;941.7033634405141;985.8373368394134;994.6469003503797;1021.8773747150241;1078.2775540387959;19681.11434985429;19943.301984430764;20245.595088098155;20247;20335.79664203339;1020.9540570674337;1026.5380578739598;1043.76515284062;1050.6637875879799;1088.2926098036182;10980.121590272758;11339.829902551468;11441;11526.88473115275;11568.24806387582;557370;570812;574452;578630;591923;100823;101613.49193253987;102118.4894075525;102820;103898.48050759698;990.8315586350194;995.5719040812376;995.9253056020827;1004.1213937804275;1020.6121673763922;17312.826871731624;17648.55878603045;17807.198676059867;17821.73267400964;17825.821741782416;43980.78009610059;44039.339409908236;44321;45028.549714502435;45723.31415028844;60987.39012609817;61167.38832611617;62795;62953.37046629658;63151.6842415785;9240.768980775534;9263.44419334815;9444.579889841352;9463.621455141718;9569.665061722806;13125.868741312846;13163;13747.450101995808;13908.930455348063;13980.720385592434;9340.486273255035;12110.818337725117;12180.147389682637;12375;12758.553450629184;11744.647660570197;12021.639350819489;12180.208286461351;12269;12324.630261092181;10567.837537870982;12380.62858114222;12604.49582016709;12800.103992720793;12960;9103.590338434919;9165.54172291396;9182.816343672956;9324.906750932403;9504.619815207314;11910.225835320676;12154.270743755404;12155.57455489089;12347.506099755909;12356.938215308866 12:59:08 INFO - PROCESS | 3485 | |3;mootools.html;1549.4809238904966;1580.1625138676502;1766.1345940489157;1883.538533059399;1886.4529286506913;8466.32269418445;9151.359404841656;9219;9791;9795.118439340458;9256.6297348106;9510.80978380432;9577.52112394381;9599;9663.226941844654;2511.2717311979504;2542.084849454195;2546.783523400504;2557.4501482181327;2564.128196413219;2453.7178224504232;2498.0132847525306;2513.8491690498536;2515.333436639292;2519.2064499682633;2505.110685706575;2522.155078048856;2530.8861101250395;2534.341071321451;2535.7464253574585;2510.4853505031424;2543.49130173965;2544.1222778141605;2564.269183282774;2578.44563418864;2421.854688718665;2423.5395274897714;2426.3570153909227;2427;2464.691913510811;9439.150476457151;9541.427514349092;9546.474943878084;9558.426494410358;9566.760830979212;5749.511291540224;5899.852503687399;5906.675132867691;5957.6127551709;6011.669358185298;3541.274038822061;3604.3692353838237;3628.89113326598;3675.3016926783826;3705.6479634434686;1168.2581560708927;1253.3733133433284;1278.9936050319689;2308.9422764430856;2321.1179751694417;13513.189208647513;13693.589192324247;13762.931185344109;13771.724565508634;13786.448542058306;4931.211006239057;5061.164907790247;5073.340465739504;5130.538251557303;5138.2806407103035;10554.683359499228;10672.62645807393;10677.78644427107;10724.249302548902;10778.676639700821;5751.079827227623;5757.136429535603;5779.595428320062;5784.88430231393;5805.071188609802;4697.6241900647865;5287.20691896211;5379.488948549882;5448.155535891943;5461.6996065216;4115.71190016696;4186.644135248477;4222.936655950163;4240.067185219247;4256.935766058486;1252.918560293578;1300.4473098932915;1300.4928078049568;1308.2150709574369;1317.157019507516;898.4878619187132;1076.9892301077045;1089.4443833644739;1095.9452027398597;1096.5010920031366;6405.839854003687;6535.117759102555;6547.116139321226;6578.309277525791;6588.8023359299295;505.91146549353715;520.3755493407925;1067.1302888146136;1126.8055860787592;1153.7404084081015;4601.539846015372;4622.399088118523;4634.1463414634145;4699.483056863743;4763.976180119077;11882;11972.760544789055;11974.042076633848;12115.818262726067;12152.027837772957;11139.387333696724;11433.656990290305;11505.769884602429;11922.1654484187;12072.637820865388;8820.558972051373;8962.283017358595;8971.596278167499;8974.237189838806;9002.23481004122;6530.738770449128;6622.238442579165;6709.261981181969;6715.4627629790475;6945.895811562729;10667.41329226869;11029.283096598696;11035.227534072537;11274.887251127384;11287.548498059985;10966.122710183006;11283.548658053585;11317.886821131684;11335.979761821476;11392.373419461677;7831.451798374059;8379.622916968872;8510;8686.739397818075;8783.5169065702;9499.43003419797;9577;9624.951875240578;9628.18160456369;9680.85478717834;8254.092049874629;8467.915320846712;8547.57262136903;8608.526531040852;8624.396292259733;8232.670693172446;8292.958535207285;8458.661653533789;8464.153584641486;8502.872456913028;7474.289942455458;7518.248175182438;7549.0563679540055;7584.203658615766;7584.658690358837;5788.9131663024245;5946.672932988728;6010.9699451502465;6024.0662697282;6027.3318613116135;5600.971995139998;5637.210790489253;5676.17695434168;5766.048601980626;5892.911606325994 12:59:08 INFO - PROCESS | 3485 | |4;prototype.html;358.0922361812805;360.9350316942951;361.7630452053905;374.58982414256377;374.6141474281491;5618.803341883025;5694.800681976131;5765.827025189245;5853.209816674747;5877.295584280559;5668.829935101953;5758.42415758424;5772.913406298909;5777.740001699923;5811.128330750379;4481.820727170909;4482.932756008662;4488.8877778055485;4498.865034048976;4520.7739613019385;4404.29531274996;4510.6918993491845;4513.413256276679;4515.729056256619;4521.547845215485;4414.448193975753;4439.289713645818;4447.0661161156195;4450.4881938577155;4476.597106260436;4489.438820147481;4509.932351014738;4522.88692782683;4530.252508336153;4532.3201519771965;3922.490076290064;3984.242993831163;3991.1419044905197;4060.796960151981;4065.1056767511395;5523.917141242885;5532.197831314477;5544.833654990316;5551.944480555183;5579.42916533419;5135.845924622267;5188.948110518884;5213.165893457029;5223;5249.527542521191;5752.878188753153;5983.371745966698;6021.51827853775;6077.3314935357075;6092.421219984094;4390.62679672225;4400.867973960786;4403.933940990888;4415.161119387306;4444.444444444444;6287.8742425151695;6316;6328.240611126648;6340.11238426616;6386.680665966683;4270.402143699885;4469.687121901501;4470.329450582373;4474.015716542355;4481.7983190756495;4506.662000349921;4532.116237333754;4534.569215924482;4536.183486972377;4537.455505339314;5154;5155.432902380735;5173.939342434792;5185.559227465632;5209.713465759344;5939.3763654816485;5967.9701601491715;6036.0644100164545;6069.3020302665755;6128.601640893327;1555.7476231633643;1564.9139297338527;1569.8587127158382;1574.9212539373216;1577.8106627204809;978.6623614852864;981.6858605246396;986.5116767200282;1003.3377970539409;1020.5203554329453;5224.477552244821;5262.97368513155;5273.947260527422;5320.201969704498;5329.360476742816;5506.981208476444;5521.365043020024;5524.392316845144;5561.360443548962;5588.329400471969;4855.717812628059;5230.686158830483;5234.869128271824;5288.312519372457;5306.7611957462;2943.9705602944123;2968.569557414163;2972.940541189164;2975.2264411252795;2984.9552656570027;5671.277786662426;5674.858128546737;5701.486866182064;5760.711964401763;5764.913526297109;5917.585768996215;6395.720855828853;6406.967965160145;6420.6468644225015;6421.389967953037;6545.803625891135;6548.297442664846;6594.406503414716;6599.241087275025;6606.474564922947;6135.447809697149;6301.8109456716375;6321.936780632135;6326.2092238470195;6342.129071923701;6254.437100660963;6263.6241825490615;6275.435210830865;6290.389488362279;6294.464970477561;6423.710933008119;6533.150690410406;6550.705218265094;6561.376669216417;6562.8359291018105;4476.529964353696;4482.0503081159795;4496.842610508616;4500.482444518922;4512.9774351128035;6035.215421995113;6175.938240617536;6285.811425657238;6405;6439.871202575829;6088.665123418255;6091.786787462417;6093.542984276286;6096.512279017757;6131.294901086432;6010.0166944907205;6103.291078498028;6104.969475152596;6112.388761123852;6116.816495505142;6016.4885984690045;6017.614235259331;6037.486813620716;6038.7282572283475;6039.939600603938;6114.541409394402;6134.957057300359;6148.44663980244;6155.199824023028;6165.167702360124;5854.970725146517;5946.464818166386;5983.311919129356;5990.251218597676;5995.850103747442 12:59:08 INFO - PROCESS | 3485 | |5;yui.html;802.085622390475;806.9596520173993;870.6517393042783;893.4848401749076;908.7955210077738;15020.474283400083;16257.34970601176;16344.75482867758;16361.263743131572;16502.587435314093;15579.610509737262;15686.686266274668;15687.372505099782;15694.843051569482;15759.684806303867;850.6002178975887;853.9965540489931;864.6195673903462;866.2290561400358;866.8829707989404;852.109545524928;854.0647990450447;854.6752234151014;854.679495189304;855.102142750113;889.9466032038066;891.3715830339628;891.8483857744199;892.7277180459957;899.1233547291404;880.7798050487346;884.1247165306332;884.4074470105013;885.3935054487632;885.8848349714495;649.8115546491512;653.0824192010233;653.5261935097064;653.8855700252484;657.0571230284557;14988.400463981428;15001.949863509559;15006.924965375212;15017.324220410108;15018.924905375403;13619.863801361958;13683.179009259376;13756.587302380945;13932.37304321308;14024.298785060706;11590.652280431601;11614.303141811519;11675.241109327866;11787.705307367385;11965.162438629299;3977.8209980550946;3993.4409182714444;4091.8772436826944;4128.772917489537;4179.226843034048;54222.45777542213;59560;69789.3021069788;70153;75727.62136189338;12129;12237.69405764863;12388.876111238953;12534.937325313314;12768.361581920866;22665.433364166027;22704.091836326694;22944.885275573848;23046.308610741704;23074.307770766904;9091.090890910988;9301.162895339452;9409.153176214173;9570.377925434825;9887.505624718735;4962.15643340633;5074.771635276422;5134.640575159778;5178.482151784867;5188.8962220755375;3756.1924186300075;3863.690904727615;3867.477890484805;3874.748141370802;3874.748141370802;711.5695004522189;711.7366574367413;717.8528401677644;721.7762493626992;728.300831202052;669.2003056347716;689.1729924091011;778.6690656470977;789.3921680306247;806.4475834053575;10399.896001040044;10435.582576697;10619.36283822973;10647.30792498485;10711.732206694895;729.5403895545772;752.6086435053742;764.8126209078812;785.7485604606585;815.6778072661384;4690.81236750533;4855.198892182821;4926.211806111005;4969.577585905166;4969.726665033458;73703.26296736964;116263;116780;121274;121299.39350303193;85525.57237213774;101823.49088254511;102676.48661756793;103483;104959;78739;89895;91602.54198729097;92539.5373023144;92640.53679731558;9592.674612456089;9613.375130616767;9714.514274286399;9742.853857192005;9775;53250.73374633102;54335.45664543304;55090.449095508535;55250.44749552614;55695.72152139214;77289.61355193188;77709;79493;80021.59989200017;80471.59764201142;11319.09447244202;12589.622311330675;12605.117641764988;12648.177868438523;12654.30401327899;14310;14351.425942962165;14389.64025899319;14519.419223230952;14566.708665826412;13926.30368481592;14061.507847225297;14100.224487653277;14148.009639325148;14204.289785510477;13106;13188.340582971005;13205.735885282433;13366.131201471873;13511.932440337736;13608.65978350549;13609.11540749848;13634.659133521742;13749.656258593215;13825.654358641115;10897.073748731129;11315.717107072389;11421.486033128363;11491.080713543064;11625.24435911663;10878.728031799268;10883.510242039285;11186.161037922026;11343.319400835977;11461.541538338373 12:59:08 INFO - PROCESS | 3485 | __end_tp_report 12:59:08 INFO - PROCESS | 3485 | __start_cc_report 12:59:08 INFO - PROCESS | 3485 | _x_x_mozilla_cycle_collect,325 12:59:08 INFO - PROCESS | 3485 | __end_cc_report 12:59:08 INFO - PROCESS | 3485 | __startTimestamp1466625548163__endTimestamp 12:59:08 INFO - PROCESS | 3485 | 12:59:08 INFO - PROCESS | 3485 | ------- Summary: start ------- 12:59:08 INFO - PROCESS | 3485 | Number of tests: 6 12:59:08 INFO - PROCESS | 3485 | 12:59:08 INFO - PROCESS | 3485 | [#0] dojo.html Cycles:165 Average:5700.84 Median:5923.44 stddev:647.42 (10.9%) stddev-sans-first:622.49 12:59:08 INFO - PROCESS | 3485 | Values: 3345.6 3380.1 3391.2 3400.4 3420.9 5643.4 5656.9 5752.0 5760.3 5767.1 5683.7 5711.7 5717.6 5722.3 5730.5 5124.5 5142.2 5183.7 5242.9 5264.8 5193.2 5197.0 5200.9 5231.1 5258.2 5164.9 5223.0 5259.1 5264.8 5304.2 5326.4 5327.2 5327.3 5330.7 5330.9 4943.5 5104.7 5211.9 5224.0 5271.4 5556.8 5581.2 5608.4 5644.9 5662.9 6133.2 6141.1 6149.9 6160.9 6169.6 6072.3 6132.1 6160.3 6216.0 6217.5 5707.7 5718.3 5729.1 5764.5 5769.8 6319.7 6344.8 6358.5 6363.7 6364.8 5933.9 5964.2 5978.7 6025.5 6072.3 6080.2 6097.9 6105.6 6115.2 6115.4 5921.3 6066.0 6069.8 6087.5 6088.3 6028.7 6051.6 6070.8 6091.1 6112.5 4625.2 4625.2 4640.5 4642.4 4655.8 4120.8 4133.4 4172.9 4176.4 4213.0 5619.4 5823.6 5915.5 5962.8 5963.2 6132.3 6192.6 6196.4 6214.9 6217.7 5696.6 5831.2 5923.4 5928.3 5963.1 5238.8 5280.4 5283.6 5311.4 5344.0 6290.3 6327.2 6328.2 6329.1 6391.9 5974.6 6116.2 6125.8 6128.5 6159.5 6402.7 6414.6 6424.4 6460.9 6465.8 6060.6 6096.0 6116.1 6124.0 6128.1 6010.3 6139.6 6175.7 6191.3 6193.1 6032.6 6079.1 6097.8 6102.1 6110.2 6065.2 6082.9 6087.7 6092.5 6098.5 5773.6 5794.0 5826.1 5849.4 5902.6 5910.4 5954.6 5966.8 5977.6 6019.0 5744.1 5886.1 5895.0 5900.5 5909.9 12:59:08 INFO - PROCESS | 3485 | 12:59:08 INFO - PROCESS | 3485 | [#1] ext.html Cycles:180 Average:72181.19 Median:43283.18 stddev:175235.21 (404.9%) stddev-sans-first:175644.35 12:59:08 INFO - PROCESS | 3485 | Values: 587.8 639.5 644.6 654.1 657.6 45275.8 45990.5 46918.5 47023.3 50104.7 45764.3 46944.8 46998.1 47067.5 47082.3 8988.6 9150.5 9198.5 9201.7 9210.7 8956.9 9087.3 9092.1 9101.6 9114.0 9162.8 9172.6 9218.9 9218.9 9228.0 9058.5 9087.3 9150.0 9163.1 9178.8 9014.1 9040.1 9104.0 9105.4 9108.2 42754.4 43060.4 43389.3 43411.8 43485.8 4042.9 4418.1 4468.1 4528.4 4586.8 32448.5 33299.3 33674.5 33770.0 34434.1 4629.6 4697.8 4709.4 4722.7 4761.2 298551.0 299975.0 300058.0 300347.0 301015.0 53925.5 60736.4 61099.4 61247.4 61388.4 39309.0 40262.8 40294.4 41776.6 42101.2 15990.4 16070.0 16075.9 16075.9 16120.0 13460.0 13539.3 13590.9 13617.7 13677.2 20753.5 20834.9 20844.6 20965.7 21041.3 7361.8 7521.5 7567.8 7661.1 7688.7 1009.2 1059.8 1114.2 1161.0 1185.1 31867.7 31981.4 32057.4 32066.0 32579.0 1145.9 1154.4 1224.8 1236.8 1271.2 16869.2 17178.4 17240.2 17372.2 17474.8 412562.0 924156.0 1057956.0 1077227.0 1082562.0 64609.7 65747.0 65874.3 66143.7 66173.0 1444.0 1449.8 1452.1 1458.2 1487.7 31730.2 33446.5 33716.7 33777.3 33886.0 55618.4 56098.7 56430.7 56543.4 56564.7 512349.0 514945.0 516660.0 517193.0 519156.0 30912.2 31222.2 31476.0 31502.4 31562.7 50236.5 50519.2 51405.0 51613.7 52117.5 42982.0 43265.0 43301.4 43778.0 44109.3 42116.0 42730.6 42790.8 42921.8 44210.0 38265.0 42632.6 43017.6 43684.3 43940.8 36775.8 37621.4 37645.6 38307.2 38406.4 28953.8 29794.3 29835.3 29963.9 30026.8 12:59:08 INFO - PROCESS | 3485 | 12:59:08 INFO - PROCESS | 3485 | [#2] jquery.html Cycles:180 Average:32225.66 Median:12221.85 stddev:94639.09 (774.3%) stddev-sans-first:94874.48 12:59:08 INFO - PROCESS | 3485 | Values: 439.1 440.4 441.4 445.1 447.4 18806.5 19356.5 20093.6 20156.0 20230.7 18708.3 19524.5 19809.3 19815.7 20086.6 5495.1 5668.5 5706.9 5711.0 5711.6 5690.6 5849.3 5915.1 5958.7 5996.6 5853.5 5991.1 6002.5 6025.2 6215.8 6166.5 6228.7 6240.7 6242.7 6251.9 5733.0 6011.9 6016.9 6022.5 6044.8 15193.7 15269.1 15278.2 22285.1 23982.3 2375.1 2500.9 2526.0 2660.8 2718.8 10803.2 10909.9 11143.6 11186.9 11432.4 2052.0 2097.3 2108.6 2133.0 2136.6 84064.0 85499.6 86053.6 88063.0 90342.0 10647.8 11477.1 11861.2 12075.7 12219.2 16737.4 16995.5 17047.0 17126.3 17137.8 8525.2 8541.9 8626.5 8823.4 8992.5 8455.4 8504.7 8515.7 8519.1 8635.7 5100.9 5117.8 5191.5 5201.2 5259.5 2092.6 2099.0 2116.6 2122.7 2158.6 941.7 985.8 994.6 1021.9 1078.3 19681.1 19943.3 20245.6 20247.0 20335.8 1021.0 1026.5 1043.8 1050.7 1088.3 10980.1 11339.8 11441.0 11526.9 11568.2 557370.0 570812.0 574452.0 578630.0 591923.0 100823.0 101613.5 102118.5 102820.0 103898.5 990.8 995.6 995.9 1004.1 1020.6 17312.8 17648.6 17807.2 17821.7 17825.8 43980.8 44039.3 44321.0 45028.5 45723.3 60987.4 61167.4 62795.0 62953.4 63151.7 9240.8 9263.4 9444.6 9463.6 9569.7 13125.9 13163.0 13747.5 13908.9 13980.7 9340.5 12110.8 12180.1 12375.0 12758.6 11744.6 12021.6 12180.2 12269.0 12324.6 10567.8 12380.6 12604.5 12800.1 12960.0 9103.6 9165.5 9182.8 9324.9 9504.6 11910.2 12154.3 12155.6 12347.5 12356.9 12:59:08 INFO - PROCESS | 3485 | 12:59:08 INFO - PROCESS | 3485 | [#3] mootools.html Cycles:180 Average:6352.21 Median:4698.55 stddev:3585.94 (76.3%) stddev-sans-first:3577.83 12:59:08 INFO - PROCESS | 3485 | Values: 1549.5 1580.2 1766.1 1883.5 1886.5 8466.3 9151.4 9219.0 9791.0 9795.1 9256.6 9510.8 9577.5 9599.0 9663.2 2511.3 2542.1 2546.8 2557.5 2564.1 2453.7 2498.0 2513.8 2515.3 2519.2 2505.1 2522.2 2530.9 2534.3 2535.7 2510.5 2543.5 2544.1 2564.3 2578.4 2421.9 2423.5 2426.4 2427.0 2464.7 9439.2 9541.4 9546.5 9558.4 9566.8 5749.5 5899.9 5906.7 5957.6 6011.7 3541.3 3604.4 3628.9 3675.3 3705.6 1168.3 1253.4 1279.0 2308.9 2321.1 13513.2 13693.6 13762.9 13771.7 13786.4 4931.2 5061.2 5073.3 5130.5 5138.3 10554.7 10672.6 10677.8 10724.2 10778.7 5751.1 5757.1 5779.6 5784.9 5805.1 4697.6 5287.2 5379.5 5448.2 5461.7 4115.7 4186.6 4222.9 4240.1 4256.9 1252.9 1300.4 1300.5 1308.2 1317.2 898.5 1077.0 1089.4 1095.9 1096.5 6405.8 6535.1 6547.1 6578.3 6588.8 505.9 520.4 1067.1 1126.8 1153.7 4601.5 4622.4 4634.1 4699.5 4764.0 11882.0 11972.8 11974.0 12115.8 12152.0 11139.4 11433.7 11505.8 11922.2 12072.6 8820.6 8962.3 8971.6 8974.2 9002.2 6530.7 6622.2 6709.3 6715.5 6945.9 10667.4 11029.3 11035.2 11274.9 11287.5 10966.1 11283.5 11317.9 11336.0 11392.4 7831.5 8379.6 8510.0 8686.7 8783.5 9499.4 9577.0 9625.0 9628.2 9680.9 8254.1 8467.9 8547.6 8608.5 8624.4 8232.7 8293.0 8458.7 8464.2 8502.9 7474.3 7518.2 7549.1 7584.2 7584.7 5788.9 5946.7 6011.0 6024.1 6027.3 5601.0 5637.2 5676.2 5766.0 5892.9 12:59:08 INFO - PROCESS | 3485 | 12:59:08 INFO - PROCESS | 3485 | [#4] prototype.html Cycles:180 Average:5049.88 Median:5583.88 stddev:1495.14 (26.8%) stddev-sans-first:1457.28 12:59:08 INFO - PROCESS | 3485 | Values: 358.1 360.9 361.8 374.6 374.6 5618.8 5694.8 5765.8 5853.2 5877.3 5668.8 5758.4 5772.9 5777.7 5811.1 4481.8 4482.9 4488.9 4498.9 4520.8 4404.3 4510.7 4513.4 4515.7 4521.5 4414.4 4439.3 4447.1 4450.5 4476.6 4489.4 4509.9 4522.9 4530.3 4532.3 3922.5 3984.2 3991.1 4060.8 4065.1 5523.9 5532.2 5544.8 5551.9 5579.4 5135.8 5188.9 5213.2 5223.0 5249.5 5752.9 5983.4 6021.5 6077.3 6092.4 4390.6 4400.9 4403.9 4415.2 4444.4 6287.9 6316.0 6328.2 6340.1 6386.7 4270.4 4469.7 4470.3 4474.0 4481.8 4506.7 4532.1 4534.6 4536.2 4537.5 5154.0 5155.4 5173.9 5185.6 5209.7 5939.4 5968.0 6036.1 6069.3 6128.6 1555.7 1564.9 1569.9 1574.9 1577.8 978.7 981.7 986.5 1003.3 1020.5 5224.5 5263.0 5273.9 5320.2 5329.4 5507.0 5521.4 5524.4 5561.4 5588.3 4855.7 5230.7 5234.9 5288.3 5306.8 2944.0 2968.6 2972.9 2975.2 2985.0 5671.3 5674.9 5701.5 5760.7 5764.9 5917.6 6395.7 6407.0 6420.6 6421.4 6545.8 6548.3 6594.4 6599.2 6606.5 6135.4 6301.8 6321.9 6326.2 6342.1 6254.4 6263.6 6275.4 6290.4 6294.5 6423.7 6533.2 6550.7 6561.4 6562.8 4476.5 4482.1 4496.8 4500.5 4513.0 6035.2 6175.9 6285.8 6405.0 6439.9 6088.7 6091.8 6093.5 6096.5 6131.3 6010.0 6103.3 6105.0 6112.4 6116.8 6016.5 6017.6 6037.5 6038.7 6039.9 6114.5 6135.0 6148.4 6155.2 6165.2 5855.0 5946.5 5983.3 5990.3 5995.9 12:59:08 INFO - PROCESS | 3485 | 12:59:08 INFO - PROCESS | 3485 | [#5] yui.html Cycles:180 Average:20862.72 Median:4110.33 stddev:29720.20 (723.1%) stddev-sans-first:29765.40 12:59:08 INFO - PROCESS | 3485 | Values: 802.1 807.0 870.7 893.5 908.8 15020.5 16257.3 16344.8 16361.3 16502.6 15579.6 15686.7 15687.4 15694.8 15759.7 850.6 854.0 864.6 866.2 866.9 852.1 854.1 854.7 854.7 855.1 889.9 891.4 891.8 892.7 899.1 880.8 884.1 884.4 885.4 885.9 649.8 653.1 653.5 653.9 657.1 14988.4 15001.9 15006.9 15017.3 15018.9 13619.9 13683.2 13756.6 13932.4 14024.3 11590.7 11614.3 11675.2 11787.7 11965.2 3977.8 3993.4 4091.9 4128.8 4179.2 54222.5 59560.0 69789.3 70153.0 75727.6 12129.0 12237.7 12388.9 12534.9 12768.4 22665.4 22704.1 22944.9 23046.3 23074.3 9091.1 9301.2 9409.2 9570.4 9887.5 4962.2 5074.8 5134.6 5178.5 5188.9 3756.2 3863.7 3867.5 3874.7 3874.7 711.6 711.7 717.9 721.8 728.3 669.2 689.2 778.7 789.4 806.4 10399.9 10435.6 10619.4 10647.3 10711.7 729.5 752.6 764.8 785.7 815.7 4690.8 4855.2 4926.2 4969.6 4969.7 73703.3 116263.0 116780.0 121274.0 121299.4 85525.6 101823.5 102676.5 103483.0 104959.0 78739.0 89895.0 91602.5 92539.5 92640.5 9592.7 9613.4 9714.5 9742.9 9775.0 53250.7 54335.5 55090.4 55250.4 55695.7 77289.6 77709.0 79493.0 80021.6 80471.6 11319.1 12589.6 12605.1 12648.2 12654.3 14310.0 14351.4 14389.6 14519.4 14566.7 13926.3 14061.5 14100.2 14148.0 14204.3 13106.0 13188.3 13205.7 13366.1 13511.9 13608.7 13609.1 13634.7 13749.7 13825.7 10897.1 11315.7 11421.5 11491.1 11625.2 10878.7 10883.5 11186.2 11343.3 11461.5 12:59:08 INFO - PROCESS | 3485 | -------- Summary: end -------- 12:59:08 INFO - PROCESS | 3485 | 12:59:08 INFO - TEST-INFO | 3485: exit 0 12:59:08 INFO - TEST-OK | dromaeo_css | took 1112253ms 12:59:08 INFO - TEST-START | kraken 12:59:08 INFO - operating with platform_type : linux_ 12:59:08 INFO - Initialising browser for kraken test... 12:59:08 INFO - TEST-INFO | started process 3730 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ8Cowj/profile http://localhost:42394/getInfo.html) 12:59:13 INFO - PROCESS | 3730 | __metrics Screen width/height:1600/1200 12:59:13 INFO - PROCESS | 3730 | colorDepth:24 12:59:13 INFO - PROCESS | 3730 | Browser inner width/height: 1024/697 12:59:13 INFO - PROCESS | 3730 | __metrics 12:59:14 ERROR - PROCESS | 3730 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 12:59:15 INFO - TEST-INFO | 3730: exit 0 12:59:15 INFO - Browser initialized. 12:59:15 INFO - Running cycle 1/1 for kraken test... 12:59:15 INFO - TEST-INFO | started process 3859 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ8Cowj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:59:26 INFO - PROCESS | 3859 | RSS: Main: 155938816 12:59:26 INFO - PROCESS | 3859 | 12:59:29 INFO - PROCESS | 3859 | Cycle 1(1): loaded http://localhost:42394/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42394/tests/kraken/driver.html?testName=audio-beat-detection) 12:59:30 INFO - PROCESS | 3859 | RSS: Main: 161280000 12:59:30 INFO - PROCESS | 3859 | 12:59:32 INFO - PROCESS | 3859 | Cycle 1(1): loaded http://localhost:42394/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42394/tests/kraken/driver.html?testName=audio-dft) 12:59:33 INFO - PROCESS | 3859 | RSS: Main: 160628736 12:59:33 INFO - PROCESS | 3859 | 12:59:36 INFO - PROCESS | 3859 | Cycle 1(1): loaded http://localhost:42394/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42394/tests/kraken/driver.html?testName=audio-fft) 12:59:37 INFO - PROCESS | 3859 | RSS: Main: 161292288 12:59:37 INFO - PROCESS | 3859 | 12:59:39 INFO - PROCESS | 3859 | Cycle 1(1): loaded http://localhost:42394/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42394/tests/kraken/driver.html?testName=audio-oscillator) 12:59:39 INFO - PROCESS | 3859 | RSS: Main: 161132544 12:59:39 INFO - PROCESS | 3859 | 12:59:41 INFO - PROCESS | 3859 | Cycle 1(1): loaded http://localhost:42394/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42394/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:59:42 INFO - PROCESS | 3859 | RSS: Main: 161116160 12:59:42 INFO - PROCESS | 3859 | 12:59:45 INFO - PROCESS | 3859 | Cycle 1(1): loaded http://localhost:42394/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42394/tests/kraken/driver.html?testName=imaging-darkroom) 12:59:46 INFO - PROCESS | 3859 | RSS: Main: 160497664 12:59:46 INFO - PROCESS | 3859 | 12:59:49 INFO - PROCESS | 3859 | Cycle 1(1): loaded http://localhost:42394/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42394/tests/kraken/driver.html?testName=imaging-desaturate) 12:59:50 INFO - PROCESS | 3859 | RSS: Main: 161431552 12:59:50 INFO - PROCESS | 3859 | 12:59:53 INFO - PROCESS | 3859 | Cycle 1(1): loaded http://localhost:42394/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42394/tests/kraken/driver.html?testName=json-parse-financial) 12:59:53 INFO - PROCESS | 3859 | RSS: Main: 161046528 12:59:53 INFO - PROCESS | 3859 | 12:59:55 INFO - PROCESS | 3859 | Cycle 1(1): loaded http://localhost:42394/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42394/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:59:55 INFO - PROCESS | 3859 | RSS: Main: 160784384 12:59:55 INFO - PROCESS | 3859 | 12:59:57 INFO - PROCESS | 3859 | Cycle 1(1): loaded http://localhost:42394/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42394/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:59:58 INFO - PROCESS | 3859 | RSS: Main: 160854016 12:59:58 INFO - PROCESS | 3859 | 13:00:00 INFO - PROCESS | 3859 | Cycle 1(1): loaded http://localhost:42394/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42394/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:00:01 INFO - PROCESS | 3859 | RSS: Main: 161107968 13:00:01 INFO - PROCESS | 3859 | 13:00:03 INFO - PROCESS | 3859 | Cycle 1(1): loaded http://localhost:42394/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42394/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:00:04 INFO - PROCESS | 3859 | RSS: Main: 161304576 13:00:04 INFO - PROCESS | 3859 | 13:00:06 INFO - PROCESS | 3859 | Cycle 1(1): loaded http://localhost:42394/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42394/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:00:07 INFO - PROCESS | 3859 | RSS: Main: 161468416 13:00:07 INFO - PROCESS | 3859 | 13:00:09 INFO - PROCESS | 3859 | Cycle 1(1): loaded http://localhost:42394/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42394/tests/kraken/driver.html?testName=ai-astar) 13:00:09 INFO - PROCESS | 3859 | RSS: Main: 162484224 13:00:09 INFO - PROCESS | 3859 | 13:00:09 INFO - PROCESS | 3859 | __start_tp_report 13:00:09 INFO - PROCESS | 3859 | _x_x_mozilla_page_load 13:00:09 INFO - PROCESS | 3859 | _x_x_mozilla_page_load_details 13:00:09 INFO - PROCESS | 3859 | |i|pagename|runs| 13:00:09 INFO - PROCESS | 3859 | |0;ai-astar;112;105;111;110;110;109;110;108;109;109 13:00:09 INFO - PROCESS | 3859 | |1;audio-beat-detection;150;125;153;182;139;151;156;124;190;135 13:00:09 INFO - PROCESS | 3859 | |2;audio-dft;162;162;162;160;164;162;162;167;162;167 13:00:09 INFO - PROCESS | 3859 | |3;audio-fft;73;75;75;187;77;76;76;74;165;77 13:00:09 INFO - PROCESS | 3859 | |4;audio-oscillator;85;85;138;86;84;87;140;86;86;133 13:00:09 INFO - PROCESS | 3859 | |5;imaging-gaussian-blur;117;117;118;117;117;118;116;117;117;118 13:00:09 INFO - PROCESS | 3859 | |6;imaging-darkroom;147;148;148;146;147;148;148;147;147;147 13:00:09 INFO - PROCESS | 3859 | |7;imaging-desaturate;95;95;98;95;95;95;96;96;95;96 13:00:09 INFO - PROCESS | 3859 | |8;json-parse-financial;53;58;54;58;53;53;53;65;57;53 13:00:09 INFO - PROCESS | 3859 | |9;json-stringify-tinderbox;60;59;62;59;59;60;59;60;61;60 13:00:09 INFO - PROCESS | 3859 | |10;stanford-crypto-aes;75;75;76;75;77;82;76;80;117;77 13:00:09 INFO - PROCESS | 3859 | |11;stanford-crypto-ccm;119;118;116;118;115;116;123;131;129;129 13:00:09 INFO - PROCESS | 3859 | |12;stanford-crypto-pbkdf2;155;155;159;153;151;165;152;154;156;157 13:00:09 INFO - PROCESS | 3859 | |13;stanford-crypto-sha256-iterative;61;65;61;61;64;61;60;60;61;61 13:00:09 INFO - PROCESS | 3859 | __end_tp_report 13:00:09 INFO - PROCESS | 3859 | __start_cc_report 13:00:09 INFO - PROCESS | 3859 | _x_x_mozilla_cycle_collect,866 13:00:09 INFO - PROCESS | 3859 | __end_cc_report 13:00:09 INFO - PROCESS | 3859 | __startTimestamp1466625609376__endTimestamp 13:00:09 INFO - PROCESS | 3859 | 13:00:09 INFO - PROCESS | 3859 | ------- Summary: start ------- 13:00:09 INFO - PROCESS | 3859 | Number of tests: 14 13:00:09 INFO - PROCESS | 3859 | 13:00:09 INFO - PROCESS | 3859 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:1.89 (1.7%) stddev-sans-first:1.73 13:00:09 INFO - PROCESS | 3859 | Values: 112.0 105.0 111.0 110.0 110.0 109.0 110.0 108.0 109.0 109.0 13:00:09 INFO - PROCESS | 3859 | 13:00:09 INFO - PROCESS | 3859 | [#1] audio-beat-detection Cycles:10 Average:150.50 Median:152.00 stddev:21.89 (14.4%) stddev-sans-first:23.22 13:00:09 INFO - PROCESS | 3859 | Values: 150.0 125.0 153.0 182.0 139.0 151.0 156.0 124.0 190.0 135.0 13:00:09 INFO - PROCESS | 3859 | 13:00:09 INFO - PROCESS | 3859 | [#2] audio-dft Cycles:10 Average:163.00 Median:162.00 stddev:2.31 (1.4%) stddev-sans-first:2.42 13:00:09 INFO - PROCESS | 3859 | Values: 162.0 162.0 162.0 160.0 164.0 162.0 162.0 167.0 162.0 167.0 13:00:09 INFO - PROCESS | 3859 | 13:00:09 INFO - PROCESS | 3859 | [#3] audio-fft Cycles:10 Average:95.50 Median:75.50 stddev:42.76 (56.6%) stddev-sans-first:44.57 13:00:09 INFO - PROCESS | 3859 | Values: 73.0 75.0 75.0 187.0 77.0 76.0 76.0 74.0 165.0 77.0 13:00:09 INFO - PROCESS | 3859 | 13:00:09 INFO - PROCESS | 3859 | [#4] audio-oscillator Cycles:10 Average:101.00 Median:85.50 stddev:24.91 (29.1%) stddev-sans-first:25.74 13:00:09 INFO - PROCESS | 3859 | Values: 85.0 85.0 138.0 86.0 84.0 87.0 140.0 86.0 86.0 133.0 13:00:09 INFO - PROCESS | 3859 | 13:00:09 INFO - PROCESS | 3859 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 13:00:09 INFO - PROCESS | 3859 | Values: 117.0 117.0 118.0 117.0 117.0 118.0 116.0 117.0 117.0 118.0 13:00:09 INFO - PROCESS | 3859 | 13:00:09 INFO - PROCESS | 3859 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 13:00:09 INFO - PROCESS | 3859 | Values: 147.0 148.0 148.0 146.0 147.0 148.0 148.0 147.0 147.0 147.0 13:00:09 INFO - PROCESS | 3859 | 13:00:09 INFO - PROCESS | 3859 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.50 stddev:0.97 (1.0%) stddev-sans-first:1.00 13:00:09 INFO - PROCESS | 3859 | Values: 95.0 95.0 98.0 95.0 95.0 95.0 96.0 96.0 95.0 96.0 13:00:09 INFO - PROCESS | 3859 | 13:00:09 INFO - PROCESS | 3859 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:55.50 stddev:3.92 (7.1%) stddev-sans-first:4.03 13:00:09 INFO - PROCESS | 3859 | Values: 53.0 58.0 54.0 58.0 53.0 53.0 53.0 65.0 57.0 53.0 13:00:09 INFO - PROCESS | 3859 | 13:00:09 INFO - PROCESS | 3859 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:0.99 (1.7%) stddev-sans-first:1.05 13:00:09 INFO - PROCESS | 3859 | Values: 60.0 59.0 62.0 59.0 59.0 60.0 59.0 60.0 61.0 60.0 13:00:09 INFO - PROCESS | 3859 | 13:00:09 INFO - PROCESS | 3859 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:76.50 stddev:12.86 (16.8%) stddev-sans-first:13.45 13:00:09 INFO - PROCESS | 3859 | Values: 75.0 75.0 76.0 75.0 77.0 82.0 76.0 80.0 117.0 77.0 13:00:09 INFO - PROCESS | 3859 | 13:00:09 INFO - PROCESS | 3859 | [#11] stanford-crypto-ccm Cycles:10 Average:121.40 Median:121.00 stddev:6.13 (5.1%) stddev-sans-first:6.44 13:00:09 INFO - PROCESS | 3859 | Values: 119.0 118.0 116.0 118.0 115.0 116.0 123.0 131.0 129.0 129.0 13:00:09 INFO - PROCESS | 3859 | 13:00:09 INFO - PROCESS | 3859 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.70 Median:155.50 stddev:4.03 (2.6%) stddev-sans-first:4.27 13:00:09 INFO - PROCESS | 3859 | Values: 155.0 155.0 159.0 153.0 151.0 165.0 152.0 154.0 156.0 157.0 13:00:09 INFO - PROCESS | 3859 | 13:00:09 INFO - PROCESS | 3859 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.50 Median:61.00 stddev:1.65 (2.7%) stddev-sans-first:1.74 13:00:09 INFO - PROCESS | 3859 | Values: 61.0 65.0 61.0 61.0 64.0 61.0 60.0 60.0 61.0 61.0 13:00:09 INFO - PROCESS | 3859 | -------- Summary: end -------- 13:00:09 INFO - PROCESS | 3859 | 13:00:10 INFO - TEST-INFO | 3859: exit 0 13:00:10 INFO - TEST-OK | kraken | took 61451ms 13:00:10 INFO - SUITE-END | took 1173s 13:00:10 INFO - Completed test suite (00:19:33) 13:00:10 INFO - javascript benchmark 13:00:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7724.1721902371855, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3345.5650765400496, 3380.104272367823, 3391.2200193955405, 3400.353932752777, 3420.880269190577, 5643.435656434354, 5656.943430565699, 5751.971240143798, 5760.337561180466, 5767.1349297605275, 5683.715814209283, 5711.657300561958, 5717.599768016241, 5722.284714410699, 5730.484256416921, 5124.513171248744, 5142.202958541413, 5183.663061900983, 5242.8689282767855, 5264.763085661154, 5193.246979188016, 5197.0, 5200.895982080356, 5231.058409486291, 5258.158694608864, 5164.870878228036, 5223.0, 5259.105951988152, 5264.763085661154, 5304.20436934461, 5326.414094449627, 5327.200919862013, 5327.280817089682, 5330.706811125387, 5330.946690533084, 4943.480934501861, 5104.744762761847, 5211.895762084775, 5223.973880130613, 5271.42014378418, 5556.777728890839, 5581.246531718247, 5608.383077861432, 5644.915326270109, 5662.886742265132, 6133.202683651141, 6141.078838174265, 6149.907751383733, 6160.8767824643255, 6169.598976066586, 6072.332043475214, 6132.141360525201, 6160.322364539942, 6216.0, 6217.471514921237, 5707.74315155819, 5718.34239062509, 5729.1119876419225, 5764.481196692276, 5769.826905192851, 6319.747210111636, 6344.777932772423, 6358.459530939829, 6363.681815909186, 6364.840878978062, 5933.910991335133, 5964.1650168976375, 5978.730957106941, 6025.457708806229, 6072.301685306246, 6080.209572755513, 6097.908531372033, 6105.603135796159, 6115.1744514490865, 6115.388461153849, 5921.289445266596, 6065.969670151621, 6069.817905462844, 6087.54343424245, 6088.269407671108, 6028.698565071729, 6051.57638965277, 6070.817875463743, 6091.086337049478, 6112.51099912006, 4625.167469855458, 4625.167469855458, 4640.512746161672, 4642.373279607277, 4655.813767449332, 4120.793960301973, 4133.379993001074, 4172.853950111731, 4176.394422808676, 4213.0, 5619.4099619540175, 5823.5923485355615, 5915.467607915222, 5962.821115366546, 5963.224780778558, 6132.263729246456, 6192.628442293477, 6196.3803619638575, 6214.875702485925, 6217.720202590895, 5696.629719068247, 5831.2127862738835, 5923.437273459101, 5928.318243402064, 5963.075723262901, 5238.842834714965, 5280.366356037223, 5283.5773138149625, 5311.362636483646, 5344.038073146793, 6290.308066112724, 6327.240731112296, 6328.177336946167, 6329.145565348619, 6391.936080639227, 5974.581779275409, 6116.2140376365605, 6125.846853828601, 6128.472568454306, 6159.5072394209255, 6402.711877965409, 6414.61512309263, 6424.421802037839, 6460.935390646221, 6465.806025819233, 6060.575784672606, 6096.0, 6116.082587611894, 6124.0201567748945, 6128.142060111677, 6010.338862725184, 6139.614800607318, 6175.660338681416, 6191.288001879841, 6193.1329613855, 6032.607880487754, 6079.118228883798, 6097.75608975636, 6102.145699602148, 6110.157901280617, 6065.211522502046, 6082.908756368746, 6087.726052327567, 6092.512598992159, 6098.481629061579, 5773.624714393551, 5794.0439827428, 5826.067829147316, 5849.444302791228, 5902.557308201816, 5910.438508341701, 5954.583179177589, 5966.820995370146, 5977.581569290108, 6019.036954087325, 5744.109663002241, 5886.05823068307, 5895.0, 5900.527957763455, 5909.91135132982], "value": 5657.552179879774, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.8354060862957, 639.5043841023204, 644.5874640230253, 654.110409842614, 657.6251536624123, 45275.77362113189, 45990.54009459904, 46918.53081469184, 47023.29465058027, 50104.74947625266, 45764.313535297, 46944.76527617357, 46998.0600387992, 47067.529324706746, 47082.29376559346, 8988.550572471366, 9150.450972941644, 9198.540072996324, 9201.72394828153, 9210.67762628308, 8956.910430895672, 9087.273018158532, 9092.090790920922, 9101.63593456261, 9114.043025482328, 9162.816743665122, 9172.633094676205, 9218.86171707425, 9218.907810921872, 9227.953860230724, 9058.456492610432, 9087.318451116193, 9150.0, 9163.129502697233, 9178.770530736718, 9014.143656352637, 9040.095990400972, 9104.044075372123, 9105.408148470327, 9108.22580080694, 42754.35868461976, 43060.354094688606, 43389.34915976263, 43411.78294108509, 43485.78257108726, 4042.8787136385954, 4418.116376724636, 4468.0840427712565, 4528.43394575678, 4586.793594288231, 32448.513272300934, 33299.334013319596, 33674.49488257678, 33770.0, 34434.13914652129, 4629.629629629621, 4697.849026988376, 4709.364235828188, 4722.669413141081, 4761.166795810719, 298551.0, 299974.99999999785, 300058.0, 300347.0, 301015.0, 53925.460745392826, 60736.39263607396, 61099.38900610937, 61247.38752612417, 61388.38611613916, 39309.0, 40262.79868600638, 40294.39558406568, 41776.58223417788, 42101.15797684029, 15990.36038558468, 16070.0, 16075.919620401823, 16075.919620401823, 16120.0, 13460.0, 13539.255340956342, 13590.864091359157, 13617.727645447036, 13677.179369237878, 20753.481162970744, 20834.89582552108, 20844.58310833775, 20965.68551471729, 21041.263555775473, 7361.779146625609, 7521.4734968551675, 7567.810804729816, 7661.118971318258, 7688.692452301957, 1009.2027298434155, 1059.7933402986498, 1114.225613198819, 1161.0073387253944, 1185.0815617896199, 31867.681323186935, 31981.360372792413, 32057.358852822814, 32066.0, 32579.0, 1145.9255148415327, 1154.417019405195, 1224.797908345131, 1236.8144778283329, 1271.1864406779669, 16869.240884159997, 17178.39875604348, 17240.224189911485, 17372.218250178772, 17474.825251747574, 412562.0, 924156.0, 1057956.0, 1077227.0, 1082562.0, 64609.67695161588, 65747.0, 65874.34125658778, 66143.66928165329, 66173.0, 1443.978340324896, 1449.7680371140777, 1452.0561634937376, 1458.1761304862719, 1487.6950225203807, 31730.206744831565, 33446.498302525, 33716.66283337135, 33777.3244535103, 33886.0, 55618.44381556295, 56098.71950640221, 56430.717846412146, 56543.434565655465, 56564.7171764155, 512349.0, 514945.0, 516660.0, 517193.0, 519156.0, 30912.227194320323, 31222.21944451316, 31476.0, 31502.36995260128, 31562.684373155975, 50236.49763502318, 50519.24221136759, 51404.97190056103, 51613.741931290104, 52117.47882521278, 42982.0, 43265.0, 43301.3504797422, 43778.0, 44109.33835992527, 42116.0, 42730.57269427266, 42790.786046069574, 42921.785391072845, 44210.0, 38265.0, 42632.57367426286, 43017.569824302605, 43684.34473482964, 43940.78029609832, 36775.816120919226, 37621.35680643691, 37645.62354376421, 38307.23385532218, 38406.423903642026, 28953.78587990732, 29794.255143620714, 29835.254118647208, 29963.850180748956, 30026.849865751406], "value": 21236.212977067713, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [439.0987026176654, 440.4076517084524, 441.384268944822, 445.14309953339813, 447.42282455632215, 18806.52983675409, 19356.51608709783, 20093.598128037447, 20156.0, 20230.696539551882, 18708.345207917726, 19524.51188720283, 19809.306674266405, 19815.702764458543, 20086.598268034668, 5495.093309603911, 5668.489835914766, 5706.942930570683, 5711.0, 5711.600187986843, 5690.57320700947, 5849.268841394825, 5915.142304365886, 5958.702064896759, 5996.550258730591, 5853.531717462614, 5991.101334799771, 6002.519798416138, 6025.246844144482, 6215.782447614334, 6166.475849552793, 6228.688565571703, 6240.719167637467, 6242.687865606724, 6251.937480625181, 5732.99672557305, 6011.909821352683, 6016.909746353808, 6022.518198544106, 6044.788432404889, 15193.696126077528, 15269.083854968627, 15278.15970121643, 22285.108595656155, 23982.28053158408, 2375.10933399975, 2500.862452565108, 2525.9621105683427, 2660.840349579031, 2718.836869787819, 10803.189760767895, 10909.945450272699, 11143.609973650884, 11186.944065279702, 11432.37121958292, 2051.9589608207903, 2097.318371529259, 2108.609907167179, 2133.0294715904224, 2136.59404713104, 84064.0, 85499.57250213771, 86053.56973215156, 88063.0, 90342.0, 10647.787044259072, 11477.081833453303, 11861.169718119821, 12075.698107547381, 12219.205751626116, 16737.414190503274, 16995.49013529596, 17047.0, 17126.314947402214, 17137.828621713874, 8525.232729054414, 8541.871871921927, 8626.482411055356, 8823.367676979778, 8992.505412202392, 8455.408121431563, 8504.744857654281, 8515.74452766418, 8519.148085191431, 8635.654573816977, 5100.897982040338, 5117.8464646060675, 5191.506806853418, 5201.245819356172, 5259.474052594786, 2092.591944570794, 2098.979010209909, 2116.5978464091772, 2122.7240458740266, 2158.589867925089, 941.7033634405141, 985.8373368394134, 994.6469003503797, 1021.8773747150241, 1078.2775540387959, 19681.11434985429, 19943.301984430764, 20245.595088098155, 20247.0, 20335.79664203339, 1020.9540570674337, 1026.5380578739598, 1043.76515284062, 1050.6637875879799, 1088.2926098036182, 10980.121590272758, 11339.829902551468, 11441.0, 11526.88473115275, 11568.24806387582, 557370.0, 570812.0, 574452.0, 578630.0, 591923.0, 100823.0, 101613.49193253987, 102118.4894075525, 102820.0, 103898.48050759698, 990.8315586350194, 995.5719040812376, 995.9253056020827, 1004.1213937804275, 1020.6121673763922, 17312.826871731624, 17648.55878603045, 17807.198676059867, 17821.73267400964, 17825.821741782416, 43980.78009610059, 44039.339409908236, 44321.0, 45028.549714502435, 45723.31415028844, 60987.39012609817, 61167.38832611617, 62795.0, 62953.37046629658, 63151.6842415785, 9240.768980775534, 9263.44419334815, 9444.579889841352, 9463.621455141718, 9569.665061722806, 13125.868741312846, 13163.0, 13747.450101995808, 13908.930455348063, 13980.720385592434, 9340.486273255035, 12110.818337725117, 12180.147389682637, 12375.0, 12758.553450629184, 11744.647660570197, 12021.639350819489, 12180.208286461351, 12269.0, 12324.630261092181, 10567.837537870982, 12380.62858114222, 12604.49582016709, 12800.103992720793, 12960.0, 9103.590338434919, 9165.54172291396, 9182.816343672956, 9324.906750932403, 9504.619815207314, 11910.225835320676, 12154.270743755404, 12155.57455489089, 12347.506099755909, 12356.938215308866], "value": 9706.933122855766, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1549.4809238904966, 1580.1625138676502, 1766.1345940489157, 1883.538533059399, 1886.4529286506913, 8466.32269418445, 9151.359404841656, 9219.0, 9791.0, 9795.118439340458, 9256.6297348106, 9510.80978380432, 9577.52112394381, 9599.0, 9663.226941844654, 2511.2717311979504, 2542.084849454195, 2546.783523400504, 2557.4501482181327, 2564.128196413219, 2453.7178224504232, 2498.0132847525306, 2513.8491690498536, 2515.333436639292, 2519.2064499682633, 2505.110685706575, 2522.155078048856, 2530.8861101250395, 2534.341071321451, 2535.7464253574585, 2510.4853505031424, 2543.49130173965, 2544.1222778141605, 2564.269183282774, 2578.44563418864, 2421.854688718665, 2423.5395274897714, 2426.3570153909227, 2427.0, 2464.691913510811, 9439.150476457151, 9541.427514349092, 9546.474943878084, 9558.426494410358, 9566.760830979212, 5749.511291540224, 5899.852503687399, 5906.675132867691, 5957.6127551709, 6011.669358185298, 3541.274038822061, 3604.3692353838237, 3628.89113326598, 3675.3016926783826, 3705.6479634434686, 1168.2581560708927, 1253.3733133433284, 1278.9936050319689, 2308.9422764430856, 2321.1179751694417, 13513.189208647513, 13693.589192324247, 13762.931185344109, 13771.724565508634, 13786.448542058306, 4931.211006239057, 5061.164907790247, 5073.340465739504, 5130.538251557303, 5138.2806407103035, 10554.683359499228, 10672.62645807393, 10677.78644427107, 10724.249302548902, 10778.676639700821, 5751.079827227623, 5757.136429535603, 5779.595428320062, 5784.88430231393, 5805.071188609802, 4697.6241900647865, 5287.20691896211, 5379.488948549882, 5448.155535891943, 5461.6996065216, 4115.71190016696, 4186.644135248477, 4222.936655950163, 4240.067185219247, 4256.935766058486, 1252.918560293578, 1300.4473098932915, 1300.4928078049568, 1308.2150709574369, 1317.157019507516, 898.4878619187132, 1076.9892301077045, 1089.4443833644739, 1095.9452027398597, 1096.5010920031366, 6405.839854003687, 6535.117759102555, 6547.116139321226, 6578.309277525791, 6588.8023359299295, 505.91146549353715, 520.3755493407925, 1067.1302888146136, 1126.8055860787592, 1153.7404084081015, 4601.539846015372, 4622.399088118523, 4634.1463414634145, 4699.483056863743, 4763.976180119077, 11882.0, 11972.760544789055, 11974.042076633848, 12115.818262726067, 12152.027837772957, 11139.387333696724, 11433.656990290305, 11505.769884602429, 11922.1654484187, 12072.637820865388, 8820.558972051373, 8962.283017358595, 8971.596278167499, 8974.237189838806, 9002.23481004122, 6530.738770449128, 6622.238442579165, 6709.261981181969, 6715.4627629790475, 6945.895811562729, 10667.41329226869, 11029.283096598696, 11035.227534072537, 11274.887251127384, 11287.548498059985, 10966.122710183006, 11283.548658053585, 11317.886821131684, 11335.979761821476, 11392.373419461677, 7831.451798374059, 8379.622916968872, 8510.0, 8686.739397818075, 8783.5169065702, 9499.43003419797, 9577.0, 9624.951875240578, 9628.18160456369, 9680.85478717834, 8254.092049874629, 8467.915320846712, 8547.57262136903, 8608.526531040852, 8624.396292259733, 8232.670693172446, 8292.958535207285, 8458.661653533789, 8464.153584641486, 8502.872456913028, 7474.289942455458, 7518.248175182438, 7549.0563679540055, 7584.203658615766, 7584.658690358837, 5788.9131663024245, 5946.672932988728, 6010.9699451502465, 6024.0662697282, 6027.3318613116135, 5600.971995139998, 5637.210790489253, 5676.17695434168, 5766.048601980626, 5892.911606325994], "value": 5090.231849782178, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.0922361812805, 360.9350316942951, 361.7630452053905, 374.58982414256377, 374.6141474281491, 5618.803341883025, 5694.800681976131, 5765.827025189245, 5853.209816674747, 5877.295584280559, 5668.829935101953, 5758.42415758424, 5772.913406298909, 5777.740001699923, 5811.128330750379, 4481.820727170909, 4482.932756008662, 4488.8877778055485, 4498.865034048976, 4520.7739613019385, 4404.29531274996, 4510.6918993491845, 4513.413256276679, 4515.729056256619, 4521.547845215485, 4414.448193975753, 4439.289713645818, 4447.0661161156195, 4450.4881938577155, 4476.597106260436, 4489.438820147481, 4509.932351014738, 4522.88692782683, 4530.252508336153, 4532.3201519771965, 3922.490076290064, 3984.242993831163, 3991.1419044905197, 4060.796960151981, 4065.1056767511395, 5523.917141242885, 5532.197831314477, 5544.833654990316, 5551.944480555183, 5579.42916533419, 5135.845924622267, 5188.948110518884, 5213.165893457029, 5223.0, 5249.527542521191, 5752.878188753153, 5983.371745966698, 6021.51827853775, 6077.3314935357075, 6092.421219984094, 4390.62679672225, 4400.867973960786, 4403.933940990888, 4415.161119387306, 4444.444444444444, 6287.8742425151695, 6316.0, 6328.240611126648, 6340.11238426616, 6386.680665966683, 4270.402143699885, 4469.687121901501, 4470.329450582373, 4474.015716542355, 4481.7983190756495, 4506.662000349921, 4532.116237333754, 4534.569215924482, 4536.183486972377, 4537.455505339314, 5154.0, 5155.432902380735, 5173.939342434792, 5185.559227465632, 5209.713465759344, 5939.3763654816485, 5967.9701601491715, 6036.0644100164545, 6069.3020302665755, 6128.601640893327, 1555.7476231633643, 1564.9139297338527, 1569.8587127158382, 1574.9212539373216, 1577.8106627204809, 978.6623614852864, 981.6858605246396, 986.5116767200282, 1003.3377970539409, 1020.5203554329453, 5224.477552244821, 5262.97368513155, 5273.947260527422, 5320.201969704498, 5329.360476742816, 5506.981208476444, 5521.365043020024, 5524.392316845144, 5561.360443548962, 5588.329400471969, 4855.717812628059, 5230.686158830483, 5234.869128271824, 5288.312519372457, 5306.7611957462, 2943.9705602944123, 2968.569557414163, 2972.940541189164, 2975.2264411252795, 2984.9552656570027, 5671.277786662426, 5674.858128546737, 5701.486866182064, 5760.711964401763, 5764.913526297109, 5917.585768996215, 6395.720855828853, 6406.967965160145, 6420.6468644225015, 6421.389967953037, 6545.803625891135, 6548.297442664846, 6594.406503414716, 6599.241087275025, 6606.474564922947, 6135.447809697149, 6301.8109456716375, 6321.936780632135, 6326.2092238470195, 6342.129071923701, 6254.437100660963, 6263.6241825490615, 6275.435210830865, 6290.389488362279, 6294.464970477561, 6423.710933008119, 6533.150690410406, 6550.705218265094, 6561.376669216417, 6562.8359291018105, 4476.529964353696, 4482.0503081159795, 4496.842610508616, 4500.482444518922, 4512.9774351128035, 6035.215421995113, 6175.938240617536, 6285.811425657238, 6405.0, 6439.871202575829, 6088.665123418255, 6091.786787462417, 6093.542984276286, 6096.512279017757, 6131.294901086432, 6010.0166944907205, 6103.291078498028, 6104.969475152596, 6112.388761123852, 6116.816495505142, 6016.4885984690045, 6017.614235259331, 6037.486813620716, 6038.7282572283475, 6039.939600603938, 6114.541409394402, 6134.957057300359, 6148.44663980244, 6155.199824023028, 6165.167702360124, 5854.970725146517, 5946.464818166386, 5983.311919129356, 5990.251218597676, 5995.850103747442], "value": 4574.465321589752, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [802.085622390475, 806.9596520173993, 870.6517393042783, 893.4848401749076, 908.7955210077738, 15020.474283400083, 16257.34970601176, 16344.75482867758, 16361.263743131572, 16502.587435314093, 15579.610509737262, 15686.686266274668, 15687.372505099782, 15694.843051569482, 15759.684806303867, 850.6002178975887, 853.9965540489931, 864.6195673903462, 866.2290561400358, 866.8829707989404, 852.109545524928, 854.0647990450447, 854.6752234151014, 854.679495189304, 855.102142750113, 889.9466032038066, 891.3715830339628, 891.8483857744199, 892.7277180459957, 899.1233547291404, 880.7798050487346, 884.1247165306332, 884.4074470105013, 885.3935054487632, 885.8848349714495, 649.8115546491512, 653.0824192010233, 653.5261935097064, 653.8855700252484, 657.0571230284557, 14988.400463981428, 15001.949863509559, 15006.924965375212, 15017.324220410108, 15018.924905375403, 13619.863801361958, 13683.179009259376, 13756.587302380945, 13932.37304321308, 14024.298785060706, 11590.652280431601, 11614.303141811519, 11675.241109327866, 11787.705307367385, 11965.162438629299, 3977.8209980550946, 3993.4409182714444, 4091.8772436826944, 4128.772917489537, 4179.226843034048, 54222.45777542213, 59560.0, 69789.3021069788, 70153.0, 75727.62136189338, 12129.0, 12237.69405764863, 12388.876111238953, 12534.937325313314, 12768.361581920866, 22665.433364166027, 22704.091836326694, 22944.885275573848, 23046.308610741704, 23074.307770766904, 9091.090890910988, 9301.162895339452, 9409.153176214173, 9570.377925434825, 9887.505624718735, 4962.15643340633, 5074.771635276422, 5134.640575159778, 5178.482151784867, 5188.8962220755375, 3756.1924186300075, 3863.690904727615, 3867.477890484805, 3874.748141370802, 3874.748141370802, 711.5695004522189, 711.7366574367413, 717.8528401677644, 721.7762493626992, 728.300831202052, 669.2003056347716, 689.1729924091011, 778.6690656470977, 789.3921680306247, 806.4475834053575, 10399.896001040044, 10435.582576697, 10619.36283822973, 10647.30792498485, 10711.732206694895, 729.5403895545772, 752.6086435053742, 764.8126209078812, 785.7485604606585, 815.6778072661384, 4690.81236750533, 4855.198892182821, 4926.211806111005, 4969.577585905166, 4969.726665033458, 73703.26296736964, 116263.0, 116780.0, 121274.0, 121299.39350303193, 85525.57237213774, 101823.49088254511, 102676.48661756793, 103483.0, 104959.0, 78739.0, 89895.0, 91602.54198729097, 92539.5373023144, 92640.53679731558, 9592.674612456089, 9613.375130616767, 9714.514274286399, 9742.853857192005, 9775.0, 53250.73374633102, 54335.45664543304, 55090.449095508535, 55250.44749552614, 55695.72152139214, 77289.61355193188, 77709.0, 79493.0, 80021.59989200017, 80471.59764201142, 11319.09447244202, 12589.622311330675, 12605.117641764988, 12648.177868438523, 12654.30401327899, 14310.0, 14351.425942962165, 14389.64025899319, 14519.419223230952, 14566.708665826412, 13926.30368481592, 14061.507847225297, 14100.224487653277, 14148.009639325148, 14204.289785510477, 13106.0, 13188.340582971005, 13205.735885282433, 13366.131201471873, 13511.932440337736, 13608.65978350549, 13609.11540749848, 13634.659133521742, 13749.656258593215, 13825.654358641115, 10897.073748731129, 11315.717107072389, 11421.486033128363, 11491.080713543064, 11625.24435911663, 10878.728031799268, 10883.510242039285, 11186.161037922026, 11343.319400835977, 11461.541538338373], "value": 7819.98124172316, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1514.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 111.0, 110.0, 110.0, 109.0, 110.0, 108.0, 109.0, 109.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 125.0, 153.0, 182.0, 139.0, 151.0, 156.0, 124.0, 190.0, 135.0], "value": 150.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 160.0, 164.0, 162.0, 162.0, 167.0, 162.0, 167.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 75.0, 187.0, 77.0, 76.0, 76.0, 74.0, 165.0, 77.0], "value": 95.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 138.0, 86.0, 84.0, 87.0, 140.0, 86.0, 86.0, 133.0], "value": 101.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 116.0, 117.0, 117.0, 118.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 146.0, 147.0, 148.0, 148.0, 147.0, 147.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 98.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 58.0, 54.0, 58.0, 53.0, 53.0, 53.0, 65.0, 57.0, 53.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 62.0, 59.0, 59.0, 60.0, 59.0, 60.0, 61.0, 60.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 75.0, 77.0, 82.0, 76.0, 80.0, 117.0, 77.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 116.0, 118.0, 115.0, 116.0, 123.0, 131.0, 129.0, 129.0], "value": 121.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 155.0, 159.0, 153.0, 151.0, 165.0, 152.0, 154.0, 156.0, 157.0], "value": 155.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 65.0, 61.0, 61.0, 64.0, 61.0, 60.0, 60.0, 61.0, 61.0], "value": 61.5, "unit": "score"}]}]} 13:00:10 INFO - Return code: 0 13:00:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:00:10 ERROR - # TBPL SUCCESS # 13:00:10 INFO - Running post-action listener: _resource_record_post_action 13:00:10 INFO - ##### 13:00:10 INFO - ##### Finished run-tests step (success) 13:00:10 INFO - ##### 13:00:10 INFO - Running post-run listener: _resource_record_post_run 13:00:10 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 7925760; Write bytes: 393166848; Read time: 1552; Write time: 308120 13:00:10 INFO - TinderboxPrint: CPU usage
13.4% 13:00:10 INFO - TinderboxPrint: I/O read bytes / time
7,925,760 / 1,552 13:00:10 INFO - TinderboxPrint: I/O write bytes / time
393,166,848 / 308,120 13:00:10 INFO - TinderboxPrint: CPU idle
8,229.1 (86.6%) 13:00:10 INFO - TinderboxPrint: CPU user
1,215.1 (12.8%) 13:00:10 INFO - TinderboxPrint: Swap in / out
0 / 0 13:00:10 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 20602880; Read time: 0; Write time: 15032 13:00:10 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 6164480; Write bytes: 372563968; Read time: 1492; Write time: 293088 13:00:11 INFO - Running post-run listener: _upload_blobber_files 13:00:11 INFO - Blob upload gear active. 13:00:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:00:11 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 13:00:11 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'] 13:00:11 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 13:00:11 INFO - (blobuploader) - INFO - Open directory for files ... 13:00:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:00:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:00:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:00:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:00:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:00:13 INFO - (blobuploader) - INFO - Done attempting. 13:00:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:00:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:00:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:00:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:00:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:00:19 INFO - (blobuploader) - INFO - Done attempting. 13:00:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:00:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:00:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:00:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:00:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:00:19 INFO - (blobuploader) - INFO - Done attempting. 13:00:19 INFO - (blobuploader) - INFO - Iteration through files over. 13:00:19 INFO - Return code: 0 13:00:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:00:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:00:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/634275e18fc0add48f4791a0271cefbf5bc6b5f23a78e687a2a6891dfcdc17f54ee039d8c0058c433b5da1a76554780aa37029367b9505bb18fdee0bd26e6561", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/933f0a2839ed72ac4f23d0b5366ed81ac91684c4021f55ab15e987ecd4ad38951fb7a081d70b20ffcd7e9006b630c1df1206d698d10346759a258e315159dd4d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36b71523b1ab750c61af04e8c71c90e05f051b5e3d5929d2a9112f21edbe0466aa8243d846d8ef37f3bdca07ae2322d201f2f3cdade133c987815fe75d1fe695"} 13:00:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:00:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:00:19 INFO - Contents: 13:00:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/634275e18fc0add48f4791a0271cefbf5bc6b5f23a78e687a2a6891dfcdc17f54ee039d8c0058c433b5da1a76554780aa37029367b9505bb18fdee0bd26e6561", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/933f0a2839ed72ac4f23d0b5366ed81ac91684c4021f55ab15e987ecd4ad38951fb7a081d70b20ffcd7e9006b630c1df1206d698d10346759a258e315159dd4d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36b71523b1ab750c61af04e8c71c90e05f051b5e3d5929d2a9112f21edbe0466aa8243d846d8ef37f3bdca07ae2322d201f2f3cdade133c987815fe75d1fe695"} 13:00:19 INFO - Running post-run listener: copy_logs_to_upload_dir 13:00:19 INFO - Copying logs to upload dir... 13:00:19 INFO - mkdir: /builds/slave/test/build/upload/logs 13:00:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.350009 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-06-22 13:00:19.962988) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 13:00:19.966964) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1466621671.815597-1120144089 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/634275e18fc0add48f4791a0271cefbf5bc6b5f23a78e687a2a6891dfcdc17f54ee039d8c0058c433b5da1a76554780aa37029367b9505bb18fdee0bd26e6561", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/933f0a2839ed72ac4f23d0b5366ed81ac91684c4021f55ab15e987ecd4ad38951fb7a081d70b20ffcd7e9006b630c1df1206d698d10346759a258e315159dd4d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36b71523b1ab750c61af04e8c71c90e05f051b5e3d5929d2a9112f21edbe0466aa8243d846d8ef37f3bdca07ae2322d201f2f3cdade133c987815fe75d1fe695"} build_url:https://queue.taskcluster.net/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011216 build_url: 'https://queue.taskcluster.net/v1/task/Oy_yeA7wSoiaPcT779fLdw/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/634275e18fc0add48f4791a0271cefbf5bc6b5f23a78e687a2a6891dfcdc17f54ee039d8c0058c433b5da1a76554780aa37029367b9505bb18fdee0bd26e6561", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/933f0a2839ed72ac4f23d0b5366ed81ac91684c4021f55ab15e987ecd4ad38951fb7a081d70b20ffcd7e9006b630c1df1206d698d10346759a258e315159dd4d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36b71523b1ab750c61af04e8c71c90e05f051b5e3d5929d2a9112f21edbe0466aa8243d846d8ef37f3bdca07ae2322d201f2f3cdade133c987815fe75d1fe695"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 13:00:19.995103) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 13:00:19.995433) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1466621671.815597-1120144089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004421 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 13:00:20.081549) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 13:00:20.082066) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 13:00:20.082580) ========= ========= Total master_lag: 0.21 =========