builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-059 starttime: 1467065914.47 results: success (0) buildid: 20160627125116 builduid: 2b4b1e947c114a8e8e9ad8a19c6e36b3 revision: f42e0b7e135a24347c414285ae531c879ee338d4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 15:18:34.473384) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 15:18:34.473860) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 15:18:34.474187) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 15:18:34.538397) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 15:18:34.538733) ========= 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=3a3620fb28aea1604ab609ef000001d2-1467062741.3069-1424095623 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 15:18:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 23.9M=0s 2016-06-27 15:18:34 (23.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128855 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 15:18:34.703940) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 15:18:34.704307) ========= 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=3a3620fb28aea1604ab609ef000001d2-1467062741.3069-1424095623 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.095893 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 15:18:34.823517) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 15:18:34.823864) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f42e0b7e135a24347c414285ae531c879ee338d4 --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 f42e0b7e135a24347c414285ae531c879ee338d4 --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=3a3620fb28aea1604ab609ef000001d2-1467062741.3069-1424095623 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 15:18:34,975 truncating revision to first 12 chars 2016-06-27 15:18:34,976 Setting DEBUG logging. 2016-06-27 15:18:34,976 attempt 1/10 2016-06-27 15:18:34,976 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f42e0b7e135a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 15:18:35,287 unpacking tar archive at: mozilla-aurora-f42e0b7e135a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.626970 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 15:18:35.468187) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 15:18:35.468917) ========= script_repo_revision: f42e0b7e135a24347c414285ae531c879ee338d4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 15:18:35.469701) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 15:18:35.470295) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 15:18:35.481512) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-27 15:18:35.481828) ========= /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=3a3620fb28aea1604ab609ef000001d2-1467062741.3069-1424095623 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:18:35 INFO - MultiFileLogger online at 20160627 15:18:35 in /builds/slave/test 15:18:35 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 15:18:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:18:35 INFO - {'append_to_log': False, 15:18:35 INFO - 'base_work_dir': '/builds/slave/test', 15:18:35 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:18:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:18:35 INFO - 'branch': 'Mozilla-Aurora', 15:18:35 INFO - 'buildbot_json_path': 'buildprops.json', 15:18:35 INFO - 'config_files': ('talos/linux_config.py',), 15:18:35 INFO - 'default_actions': ('clobber', 15:18:35 INFO - 'read-buildbot-config', 15:18:35 INFO - 'download-and-extract', 15:18:35 INFO - 'populate-webroot', 15:18:35 INFO - 'create-virtualenv', 15:18:35 INFO - 'install', 15:18:35 INFO - 'run-tests'), 15:18:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:18:35 INFO - 'download_minidump_stackwalk': True, 15:18:35 INFO - 'download_symbols': 'ondemand', 15:18:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:18:35 INFO - 'tooltool.py': '/tools/tooltool.py', 15:18:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:18:35 INFO - '/tools/misc-python/virtualenv.py')}, 15:18:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:18:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:18:35 INFO - 'installer_path': 'installer.exe', 15:18:35 INFO - 'log_level': 'info', 15:18:35 INFO - 'log_name': 'talos', 15:18:35 INFO - 'log_to_console': True, 15:18:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:18:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:18:35 INFO - 'opt_config_files': (), 15:18:35 INFO - 'pip_index': False, 15:18:35 INFO - 'sps_profile': False, 15:18:35 INFO - 'sps_profile_interval': 0, 15:18:35 INFO - 'suite': 'dromaeojs-e10s', 15:18:35 INFO - 'system_bits': '32', 15:18:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:18:35 INFO - 'title': 'talos-linux64-ix-059', 15:18:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:18:35 INFO - 'use_talos_json': True, 15:18:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:18:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:18:35 INFO - 'work_dir': 'build'} 15:18:35 INFO - ##### 15:18:35 INFO - ##### Running clobber step. 15:18:35 INFO - ##### 15:18:35 INFO - Running pre-action listener: _resource_record_pre_action 15:18:35 INFO - Running main action method: clobber 15:18:35 INFO - rmtree: /builds/slave/test/build 15:18:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:18:40 INFO - Running post-action listener: _resource_record_post_action 15:18:40 INFO - ##### 15:18:40 INFO - ##### Finished clobber step (success) 15:18:40 INFO - ##### 15:18:40 INFO - ##### 15:18:40 INFO - ##### Running read-buildbot-config step. 15:18:40 INFO - ##### 15:18:40 INFO - Running pre-action listener: _resource_record_pre_action 15:18:40 INFO - Running main action method: read_buildbot_config 15:18:40 INFO - Using buildbot properties: 15:18:40 INFO - { 15:18:40 INFO - "project": "", 15:18:40 INFO - "product": "firefox", 15:18:40 INFO - "script_repo_revision": "production", 15:18:40 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 15:18:40 INFO - "repository": "", 15:18:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 15:18:40 INFO - "buildid": "20160627125116", 15:18:40 INFO - "pgo_build": "True", 15:18:40 INFO - "basedir": "/builds/slave/test", 15:18:40 INFO - "buildnumber": 420, 15:18:40 INFO - "slavename": "talos-linux64-ix-059", 15:18:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:18:40 INFO - "platform": "ubuntu64_hw", 15:18:40 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:18:40 INFO - "branch": "mozilla-aurora", 15:18:40 INFO - "repo_path": "releases/mozilla-aurora", 15:18:40 INFO - "revision": "f42e0b7e135a24347c414285ae531c879ee338d4", 15:18:40 INFO - "stage_platform": "linux64-pgo", 15:18:40 INFO - "builduid": "2b4b1e947c114a8e8e9ad8a19c6e36b3", 15:18:40 INFO - "slavebuilddir": "test" 15:18:40 INFO - } 15:18:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/DC-qWlWAQqmJie5ZmozaNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 15:18:40 INFO - Running post-action listener: _resource_record_post_action 15:18:40 INFO - ##### 15:18:40 INFO - ##### Finished read-buildbot-config step (success) 15:18:40 INFO - ##### 15:18:40 INFO - ##### 15:18:40 INFO - ##### Running download-and-extract step. 15:18:40 INFO - ##### 15:18:40 INFO - Running pre-action listener: _resource_record_pre_action 15:18:40 INFO - Running main action method: download_and_extract 15:18:40 INFO - mkdir: /builds/slave/test/build/tests 15:18:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:40 INFO - https://queue.taskcluster.net/v1/task/DC-qWlWAQqmJie5ZmozaNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:18:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC-qWlWAQqmJie5ZmozaNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 15:18:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC-qWlWAQqmJie5ZmozaNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 15:18:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC-qWlWAQqmJie5ZmozaNg/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 15:18:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC-qWlWAQqmJie5ZmozaNg/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 15:18:43 INFO - Downloaded 1361 bytes. 15:18:43 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 15:18:43 INFO - Using the following test package requirements: 15:18:43 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 15:18:43 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:18:43 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:18:43 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:18:43 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 15:18:43 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:18:43 INFO - u'jsshell-linux-x86_64.zip'], 15:18:43 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:18:43 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:18:43 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 15:18:43 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:18:43 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:18:43 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:18:43 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:18:43 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:18:43 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:18:43 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:18:43 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:18:43 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:18:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:43 INFO - https://queue.taskcluster.net/v1/task/DC-qWlWAQqmJie5ZmozaNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:18:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC-qWlWAQqmJie5ZmozaNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:18:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC-qWlWAQqmJie5ZmozaNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:18:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC-qWlWAQqmJie5ZmozaNg/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 15:18:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC-qWlWAQqmJie5ZmozaNg/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 15:18:48 INFO - Downloaded 24524171 bytes. 15:18:48 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'] 15:18:48 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 15:18:50 INFO - Return code: 0 15:18:50 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 15:18:50 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')]} 15:18:50 INFO - https://queue.taskcluster.net/v1/task/DC-qWlWAQqmJie5ZmozaNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:18:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC-qWlWAQqmJie5ZmozaNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:18:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC-qWlWAQqmJie5ZmozaNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:18:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC-qWlWAQqmJie5ZmozaNg/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 15:18:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC-qWlWAQqmJie5ZmozaNg/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 15:18:51 INFO - Downloaded 24524171 bytes. 15:18:51 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'] 15:18:51 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 15:18:53 INFO - Return code: 0 15:18:53 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')]} 15:18:53 INFO - https://queue.taskcluster.net/v1/task/DC-qWlWAQqmJie5ZmozaNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:18:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC-qWlWAQqmJie5ZmozaNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 15:18:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC-qWlWAQqmJie5ZmozaNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 15:18:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC-qWlWAQqmJie5ZmozaNg/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 15:18:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC-qWlWAQqmJie5ZmozaNg/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 15:18:54 INFO - Downloaded 10833369 bytes. 15:18:54 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'] 15:18:54 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 15:18:54 INFO - Return code: 0 15:18: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')]} 15:18:54 INFO - https://queue.taskcluster.net/v1/task/DC-qWlWAQqmJie5ZmozaNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:18:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC-qWlWAQqmJie5ZmozaNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:18:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC-qWlWAQqmJie5ZmozaNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:18:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC-qWlWAQqmJie5ZmozaNg/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 15:18:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DC-qWlWAQqmJie5ZmozaNg/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 15:18:55 INFO - Downloaded 63615140 bytes. 15:18:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DC-qWlWAQqmJie5ZmozaNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:18:55 INFO - mkdir: /builds/slave/test/properties 15:18:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:18:55 INFO - Writing to file /builds/slave/test/properties/build_url 15:18:55 INFO - Contents: 15:18:55 INFO - build_url:https://queue.taskcluster.net/v1/task/DC-qWlWAQqmJie5ZmozaNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:18:56 INFO - Running post-action listener: _resource_record_post_action 15:18:56 INFO - Running post-action listener: set_extra_try_arguments 15:18:56 INFO - ##### 15:18:56 INFO - ##### Finished download-and-extract step (success) 15:18:56 INFO - ##### 15:18:56 INFO - ##### 15:18:56 INFO - ##### Running populate-webroot step. 15:18:56 INFO - ##### 15:18:56 INFO - Running pre-action listener: _resource_record_pre_action 15:18:56 INFO - Running main action method: populate_webroot 15:18:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:18:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:18:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:18:56 INFO - '--tppagecycles', 15:18:56 INFO - '7'], 15:18:56 INFO - 'tests': ['tsvgm']}}, 15:18:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:18:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:18:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:18:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:18:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:18:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:18:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:56 INFO - 'talos_options': ['--disable-e10s'], 15:18:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:18:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:18:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:56 INFO - 'talos_options': ['--disable-e10s'], 15:18:56 INFO - 'tests': ['damp', 'tps']}, 15:18:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:56 INFO - 'tests': ['damp', 'tps']}, 15:18:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:18:56 INFO - 'tests': ['dromaeo_dom']}, 15:18:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:18:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:18:56 INFO - 'tests': ['a11yr', 15:18:56 INFO - 'ts_paint', 15:18:56 INFO - 'tpaint', 15:18:56 INFO - 'sessionrestore', 15:18:56 INFO - 'sessionrestore_no_auto_restore', 15:18:56 INFO - 'tabpaint']}, 15:18:56 INFO - 'other-e10s': {'tests': ['a11yr', 15:18:56 INFO - 'ts_paint', 15:18:56 INFO - 'tpaint', 15:18:56 INFO - 'sessionrestore', 15:18:56 INFO - 'sessionrestore_no_auto_restore', 15:18:56 INFO - 'tabpaint']}, 15:18:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:18:56 INFO - 'ts_paint', 15:18:56 INFO - 'tpaint', 15:18:56 INFO - 'sessionrestore', 15:18:56 INFO - 'sessionrestore_no_auto_restore', 15:18:56 INFO - 'tabpaint']}, 15:18:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:18:56 INFO - 'ts_paint', 15:18:56 INFO - 'tpaint', 15:18:56 INFO - 'sessionrestore', 15:18:56 INFO - 'sessionrestore_no_auto_restore', 15:18:56 INFO - 'tabpaint']}, 15:18:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:18:56 INFO - 'tests': ['a11yr', 15:18:56 INFO - 'ts_paint', 15:18:56 INFO - 'tpaint', 15:18:56 INFO - 'sessionrestore', 15:18:56 INFO - 'sessionrestore_no_auto_restore', 15:18:56 INFO - 'tabpaint']}, 15:18:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:18:56 INFO - 'tests': ['a11yr', 15:18:56 INFO - 'ts_paint', 15:18:56 INFO - 'tpaint', 15:18:56 INFO - 'sessionrestore', 15:18:56 INFO - 'sessionrestore_no_auto_restore', 15:18:56 INFO - 'tabpaint']}, 15:18:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:18:56 INFO - 'tests': ['tsvgx', 15:18:56 INFO - 'tsvgr_opacity', 15:18:56 INFO - 'tart', 15:18:56 INFO - 'tscrollx', 15:18:56 INFO - 'cart']}, 15:18:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:18:56 INFO - 'tsvgr_opacity', 15:18:56 INFO - 'tart', 15:18:56 INFO - 'tscrollx', 15:18:56 INFO - 'cart']}, 15:18:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:56 INFO - 'talos_options': ['--disable-e10s'], 15:18:56 INFO - 'tests': ['tp5o']}, 15:18:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:56 INFO - 'tests': ['tp5o']}, 15:18:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:56 INFO - 'talos_options': ['--disable-e10s', 15:18:56 INFO - '--xperf_path', 15:18:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:18:56 INFO - 'tests': ['tp5n']}, 15:18:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:18:56 INFO - 'talos_options': ['--xperf_path', 15:18:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:18:56 INFO - 'tests': ['tp5n']}}, 15:18:56 INFO - 'talos.zip': {'path': '', 15:18:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:18:56 INFO - Running post-action listener: _resource_record_post_action 15:18:56 INFO - ##### 15:18:56 INFO - ##### Finished populate-webroot step (success) 15:18:56 INFO - ##### 15:18:56 INFO - ##### 15:18:56 INFO - ##### Running create-virtualenv step. 15:18:56 INFO - ##### 15:18:56 INFO - Running pre-action listener: _resource_record_pre_action 15:18:56 INFO - Running main action method: create_virtualenv 15:18:56 INFO - Creating virtualenv /builds/slave/test/build/venv 15:18:56 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 15:18:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:18:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:18:56 INFO - Using real prefix '/usr' 15:18:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:18:57 INFO - Installing distribute.............................................................................................................................................................................................done. 15:18:59 INFO - Installing pip.................done. 15:18:59 INFO - Return code: 0 15:18:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:18: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')]} 15:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18: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')]} 15:18:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5531622f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f95450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20242c0>, '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 0x20251c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2025650>, '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': '3a3620fb28aea1604ab609ef000001d2-1467062741.3069-1424095623', '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 15:18: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', 'pip>=1.5'] in /builds/slave/test/build 15:18: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 pip>=1.5 15:18:59 INFO - Using env: {'DISPLAY': ':0', 15:18:59 INFO - 'HOME': '/home/cltbld', 15:18:59 INFO - 'LANG': 'en_US.UTF-8', 15:18:59 INFO - 'LANGUAGE': 'en_US:en', 15:18:59 INFO - 'LOGNAME': 'cltbld', 15:18:59 INFO - 'MAIL': '/var/mail/cltbld', 15:18:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:59 INFO - 'MOZ_NO_REMOTE': '1', 15:18:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:59 INFO - 'NO_EM_RESTART': '1', 15:18:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:59 INFO - 'PWD': '/builds/slave/test', 15:18:59 INFO - 'SHELL': '/bin/bash', 15:18:59 INFO - 'SHLVL': '1', 15:18:59 INFO - 'TERM': 'linux', 15:18:59 INFO - 'TMOUT': '86400', 15:18:59 INFO - 'USER': 'cltbld', 15:18:59 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467062741.3069-1424095623', 15:18:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:59 INFO - '_': '/tools/buildbot/bin/python'} 15:18:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:59 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 15:18:59 INFO - Cleaning up... 15:18:59 INFO - Return code: 0 15:18:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:18: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')]} 15:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18: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')]} 15:18:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18: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', '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 0x7f5531622f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f95450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20242c0>, '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 0x20251c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2025650>, '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': '3a3620fb28aea1604ab609ef000001d2-1467062741.3069-1424095623', '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 15:18: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', 'psutil>=3.1.1'] in /builds/slave/test/build 15:18: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 psutil>=3.1.1 15:18:59 INFO - Using env: {'DISPLAY': ':0', 15:18:59 INFO - 'HOME': '/home/cltbld', 15:18:59 INFO - 'LANG': 'en_US.UTF-8', 15:18:59 INFO - 'LANGUAGE': 'en_US:en', 15:18:59 INFO - 'LOGNAME': 'cltbld', 15:18:59 INFO - 'MAIL': '/var/mail/cltbld', 15:18:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:59 INFO - 'MOZ_NO_REMOTE': '1', 15:18:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:59 INFO - 'NO_EM_RESTART': '1', 15:18:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:59 INFO - 'PWD': '/builds/slave/test', 15:18:59 INFO - 'SHELL': '/bin/bash', 15:18:59 INFO - 'SHLVL': '1', 15:18:59 INFO - 'TERM': 'linux', 15:18:59 INFO - 'TMOUT': '86400', 15:18:59 INFO - 'USER': 'cltbld', 15:18:59 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467062741.3069-1424095623', 15:18:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:59 INFO - '_': '/tools/buildbot/bin/python'} 15:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:00 INFO - Downloading/unpacking psutil>=3.1.1 15:19: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 15:19: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 15:19: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 15:19: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 15:19: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 15:19: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 15:19:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:19:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:19:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:19:02 INFO - Installing collected packages: psutil 15:19:02 INFO - Running setup.py install for psutil 15:19:02 INFO - building 'psutil._psutil_linux' extension 15:19:02 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 15:19:03 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 15:19:03 INFO - building 'psutil._psutil_posix' extension 15:19:03 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 15:19:03 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 15:19:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:19:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:19:03 INFO - Successfully installed psutil 15:19:03 INFO - Cleaning up... 15:19:03 INFO - Return code: 0 15:19:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:03 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 0x7f5531622f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f95450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20242c0>, '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 0x20251c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2025650>, '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': '3a3620fb28aea1604ab609ef000001d2-1467062741.3069-1424095623', '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 15:19:03 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 15:19:03 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 15:19:03 INFO - Using env: {'DISPLAY': ':0', 15:19:03 INFO - 'HOME': '/home/cltbld', 15:19:03 INFO - 'LANG': 'en_US.UTF-8', 15:19:03 INFO - 'LANGUAGE': 'en_US:en', 15:19:03 INFO - 'LOGNAME': 'cltbld', 15:19:03 INFO - 'MAIL': '/var/mail/cltbld', 15:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:03 INFO - 'MOZ_NO_REMOTE': '1', 15:19:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:03 INFO - 'NO_EM_RESTART': '1', 15:19:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:03 INFO - 'PWD': '/builds/slave/test', 15:19:03 INFO - 'SHELL': '/bin/bash', 15:19:03 INFO - 'SHLVL': '1', 15:19:03 INFO - 'TERM': 'linux', 15:19:03 INFO - 'TMOUT': '86400', 15:19:03 INFO - 'USER': 'cltbld', 15:19:03 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467062741.3069-1424095623', 15:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:03 INFO - '_': '/tools/buildbot/bin/python'} 15:19:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:19:03 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 15:19:03 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 15:19:03 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 15:19:03 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 15:19:03 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 15:19:03 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 15:19:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:19:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:19:05 INFO - Installing collected packages: mozsystemmonitor 15:19:05 INFO - Running setup.py install for mozsystemmonitor 15:19:05 INFO - Successfully installed mozsystemmonitor 15:19:05 INFO - Cleaning up... 15:19:05 INFO - Return code: 0 15:19:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:19:05 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')]} 15:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:05 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')]} 15:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:05 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 0x7f5531622f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f95450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20242c0>, '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 0x20251c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2025650>, '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': '3a3620fb28aea1604ab609ef000001d2-1467062741.3069-1424095623', '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 15:19:05 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 15:19:05 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 15:19:05 INFO - Using env: {'DISPLAY': ':0', 15:19:05 INFO - 'HOME': '/home/cltbld', 15:19:05 INFO - 'LANG': 'en_US.UTF-8', 15:19:05 INFO - 'LANGUAGE': 'en_US:en', 15:19:05 INFO - 'LOGNAME': 'cltbld', 15:19:05 INFO - 'MAIL': '/var/mail/cltbld', 15:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:05 INFO - 'MOZ_NO_REMOTE': '1', 15:19:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:05 INFO - 'NO_EM_RESTART': '1', 15:19:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:05 INFO - 'PWD': '/builds/slave/test', 15:19:05 INFO - 'SHELL': '/bin/bash', 15:19:05 INFO - 'SHLVL': '1', 15:19:05 INFO - 'TERM': 'linux', 15:19:05 INFO - 'TMOUT': '86400', 15:19:05 INFO - 'USER': 'cltbld', 15:19:05 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467062741.3069-1424095623', 15:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:05 INFO - '_': '/tools/buildbot/bin/python'} 15:19:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:06 INFO - Downloading/unpacking jsonschema==2.5.1 15:19:06 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 15:19:06 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 15:19:06 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 15:19:06 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 15:19:06 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 15:19:06 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 15:19:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:19:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:19: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 15:19: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 15:19: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 15:19: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 15:19: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 15:19: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 15:19:08 INFO - Downloading functools32-3.2.3-2.tar.gz 15:19:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:19:08 INFO - warning: no files found matching '*.txt' 15:19:08 INFO - no previously-included directories found matching 'build' 15:19:08 INFO - no previously-included directories found matching 'dist' 15:19:08 INFO - no previously-included directories found matching '.git*' 15:19:08 INFO - Installing collected packages: jsonschema, functools32 15:19:08 INFO - Running setup.py install for functools32 15:19:08 INFO - warning: no files found matching '*.txt' 15:19:08 INFO - no previously-included directories found matching 'build' 15:19:08 INFO - no previously-included directories found matching 'dist' 15:19:08 INFO - no previously-included directories found matching '.git*' 15:19:08 INFO - Successfully installed jsonschema functools32 15:19:08 INFO - Cleaning up... 15:19:08 INFO - Return code: 0 15:19:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:19: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')]} 15:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19: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')]} 15:19:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:08 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 0x7f5531622f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f95450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20242c0>, '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 0x20251c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2025650>, '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': '3a3620fb28aea1604ab609ef000001d2-1467062741.3069-1424095623', '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 15:19:08 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 15:19:08 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 15:19:08 INFO - Using env: {'DISPLAY': ':0', 15:19:08 INFO - 'HOME': '/home/cltbld', 15:19:08 INFO - 'LANG': 'en_US.UTF-8', 15:19:08 INFO - 'LANGUAGE': 'en_US:en', 15:19:08 INFO - 'LOGNAME': 'cltbld', 15:19:08 INFO - 'MAIL': '/var/mail/cltbld', 15:19:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:08 INFO - 'MOZ_NO_REMOTE': '1', 15:19:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:08 INFO - 'NO_EM_RESTART': '1', 15:19:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:08 INFO - 'PWD': '/builds/slave/test', 15:19:08 INFO - 'SHELL': '/bin/bash', 15:19:08 INFO - 'SHLVL': '1', 15:19:08 INFO - 'TERM': 'linux', 15:19:08 INFO - 'TMOUT': '86400', 15:19:08 INFO - 'USER': 'cltbld', 15:19:08 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467062741.3069-1424095623', 15:19:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:08 INFO - '_': '/tools/buildbot/bin/python'} 15:19:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:08 INFO - Downloading/unpacking blobuploader==1.2.4 15:19:08 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 15:19:08 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 15:19:08 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 15:19:08 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 15:19:08 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 15:19:08 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 15:19:10 INFO - Downloading blobuploader-1.2.4.tar.gz 15:19:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:19:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:19:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:11 INFO - Downloading docopt-0.6.1.tar.gz 15:19:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:19:11 INFO - Installing collected packages: blobuploader, requests, docopt 15:19:11 INFO - Running setup.py install for blobuploader 15:19:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:19:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:19:11 INFO - Running setup.py install for requests 15:19:11 INFO - Running setup.py install for docopt 15:19:11 INFO - Successfully installed blobuploader requests docopt 15:19:11 INFO - Cleaning up... 15:19:11 INFO - Return code: 0 15:19:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:19: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')]} 15:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19: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')]} 15:19:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:11 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 0x7f5531622f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f95450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20242c0>, '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 0x20251c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2025650>, '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': '3a3620fb28aea1604ab609ef000001d2-1467062741.3069-1424095623', '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 15:19:11 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 15:19:11 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 15:19:11 INFO - Using env: {'DISPLAY': ':0', 15:19:11 INFO - 'HOME': '/home/cltbld', 15:19:11 INFO - 'LANG': 'en_US.UTF-8', 15:19:11 INFO - 'LANGUAGE': 'en_US:en', 15:19:11 INFO - 'LOGNAME': 'cltbld', 15:19:11 INFO - 'MAIL': '/var/mail/cltbld', 15:19:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:11 INFO - 'MOZ_NO_REMOTE': '1', 15:19:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:11 INFO - 'NO_EM_RESTART': '1', 15:19:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:11 INFO - 'PWD': '/builds/slave/test', 15:19:11 INFO - 'SHELL': '/bin/bash', 15:19:11 INFO - 'SHLVL': '1', 15:19:11 INFO - 'TERM': 'linux', 15:19:11 INFO - 'TMOUT': '86400', 15:19:11 INFO - 'USER': 'cltbld', 15:19:11 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467062741.3069-1424095623', 15:19:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:11 INFO - '_': '/tools/buildbot/bin/python'} 15:19:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:19:12 INFO - Running setup.py (path:/tmp/pip-UgMLTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:19:12 INFO - Running setup.py (path:/tmp/pip-ETdDQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:19:12 INFO - Running setup.py (path:/tmp/pip-cbGpT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:19:12 INFO - Running setup.py (path:/tmp/pip-QmdzrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:19:12 INFO - Running setup.py (path:/tmp/pip-FR3YYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:19:12 INFO - Running setup.py (path:/tmp/pip-rAUSjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:19:12 INFO - Running setup.py (path:/tmp/pip-WkvzGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:19:12 INFO - Running setup.py (path:/tmp/pip-jwt4D5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:19:12 INFO - Running setup.py (path:/tmp/pip-dL11Sc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:19:12 INFO - Running setup.py (path:/tmp/pip-rRuFAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:19:12 INFO - Running setup.py (path:/tmp/pip-_lj_1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:19:12 INFO - Running setup.py (path:/tmp/pip-qjip3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:19:12 INFO - Running setup.py (path:/tmp/pip-tbQMVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:19:13 INFO - Running setup.py (path:/tmp/pip-SJvukU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:19:13 INFO - Running setup.py (path:/tmp/pip-zPTGRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:19:13 INFO - Running setup.py (path:/tmp/pip-N8yOAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:19:13 INFO - Running setup.py (path:/tmp/pip-vzAZhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:19:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:19:13 INFO - Running setup.py install for manifestparser 15:19:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:19:13 INFO - Running setup.py install for mozcrash 15:19:13 INFO - Running setup.py install for mozdebug 15:19:13 INFO - Running setup.py install for mozdevice 15:19:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:19:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:19:13 INFO - Running setup.py install for mozfile 15:19:13 INFO - Running setup.py install for mozhttpd 15:19:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:19:13 INFO - Running setup.py install for mozinfo 15:19:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:19:14 INFO - Running setup.py install for mozInstall 15:19:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:19:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:19:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:19:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:19:14 INFO - Running setup.py install for mozleak 15:19:14 INFO - Running setup.py install for mozlog 15:19:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:19:14 INFO - Running setup.py install for moznetwork 15:19:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:19:14 INFO - Running setup.py install for mozprocess 15:19:14 INFO - Running setup.py install for mozprofile 15:19:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:19:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:19:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:19:14 INFO - Running setup.py install for mozrunner 15:19:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:19:14 INFO - Running setup.py install for mozscreenshot 15:19:14 INFO - Running setup.py install for moztest 15:19:14 INFO - Running setup.py install for mozversion 15:19:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:19:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:19:15 INFO - Cleaning up... 15:19:15 INFO - Return code: 0 15:19:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:19: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')]} 15:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19: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')]} 15:19:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:15 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 0x7f5531622f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f95450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20242c0>, '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 0x20251c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2025650>, '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': '3a3620fb28aea1604ab609ef000001d2-1467062741.3069-1424095623', '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 15:19:15 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 15:19:15 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 15:19:15 INFO - Using env: {'DISPLAY': ':0', 15:19:15 INFO - 'HOME': '/home/cltbld', 15:19:15 INFO - 'LANG': 'en_US.UTF-8', 15:19:15 INFO - 'LANGUAGE': 'en_US:en', 15:19:15 INFO - 'LOGNAME': 'cltbld', 15:19:15 INFO - 'MAIL': '/var/mail/cltbld', 15:19:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:15 INFO - 'MOZ_NO_REMOTE': '1', 15:19:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:15 INFO - 'NO_EM_RESTART': '1', 15:19:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:15 INFO - 'PWD': '/builds/slave/test', 15:19:15 INFO - 'SHELL': '/bin/bash', 15:19:15 INFO - 'SHLVL': '1', 15:19:15 INFO - 'TERM': 'linux', 15:19:15 INFO - 'TMOUT': '86400', 15:19:15 INFO - 'USER': 'cltbld', 15:19:15 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467062741.3069-1424095623', 15:19:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:15 INFO - '_': '/tools/buildbot/bin/python'} 15:19:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:19:15 INFO - Running setup.py (path:/tmp/pip-tHrExt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:19:15 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)) 15:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:19:15 INFO - Running setup.py (path:/tmp/pip-T8hjx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:19:15 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)) 15:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:19:15 INFO - Running setup.py (path:/tmp/pip-670rBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:19:15 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)) 15:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:19:15 INFO - Running setup.py (path:/tmp/pip-OQ8Mj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:19:15 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)) 15:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:19:15 INFO - Running setup.py (path:/tmp/pip-X9HNBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:19:15 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)) 15:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:19:15 INFO - Running setup.py (path:/tmp/pip-x36qdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:19:15 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)) 15:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:19:15 INFO - Running setup.py (path:/tmp/pip-PV7H_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:19:15 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)) 15:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:19:15 INFO - Running setup.py (path:/tmp/pip-dIxDpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:19:15 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)) 15:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:19:15 INFO - Running setup.py (path:/tmp/pip-_RTOgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:19:15 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)) 15:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:19:15 INFO - Running setup.py (path:/tmp/pip-IEqY5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:19:16 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)) 15:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:19:16 INFO - Running setup.py (path:/tmp/pip-8lkzFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:19:16 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)) 15:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:19:16 INFO - Running setup.py (path:/tmp/pip-3AAcvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:19:16 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)) 15:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:19:16 INFO - Running setup.py (path:/tmp/pip-bXMzBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:19:16 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)) 15:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:19:16 INFO - Running setup.py (path:/tmp/pip-32Wkfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:19:16 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)) 15:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:19:16 INFO - Running setup.py (path:/tmp/pip-XQeR5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:19:16 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)) 15:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:19:16 INFO - Running setup.py (path:/tmp/pip-UVJcyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:19:16 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)) 15:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:19:16 INFO - Running setup.py (path:/tmp/pip-aL2RDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:19:16 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)) 15:19:16 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)) 15:19:16 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)) 15:19:16 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)) 15:19:16 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)) 15:19:16 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)) 15:19:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:19: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 15:19: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 15:19: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 15:19: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 15:19: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 15:19: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 15:19:18 INFO - Downloading blessings-1.6.tar.gz 15:19:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:19:18 INFO - Installing collected packages: blessings 15:19:18 INFO - Running setup.py install for blessings 15:19:18 INFO - Successfully installed blessings 15:19:18 INFO - Cleaning up... 15:19:18 INFO - Return code: 0 15:19:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:19:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:19:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:19:18 INFO - Reading from file tmpfile_stdout 15:19:18 INFO - Current package versions: 15:19:18 INFO - argparse == 1.2.1 15:19:18 INFO - blessings == 1.6 15:19:18 INFO - blobuploader == 1.2.4 15:19:18 INFO - docopt == 0.6.1 15:19:18 INFO - functools32 == 3.2.3-2 15:19:18 INFO - jsonschema == 2.5.1 15:19:18 INFO - manifestparser == 1.1 15:19:18 INFO - mozInstall == 1.12 15:19:18 INFO - mozcrash == 0.17 15:19:18 INFO - mozdebug == 0.1 15:19:18 INFO - mozdevice == 0.48 15:19:18 INFO - mozfile == 1.2 15:19:18 INFO - mozhttpd == 0.7 15:19:18 INFO - mozinfo == 0.9 15:19:18 INFO - mozleak == 0.1 15:19:18 INFO - mozlog == 3.2 15:19:18 INFO - moznetwork == 0.27 15:19:18 INFO - mozprocess == 0.22 15:19:18 INFO - mozprofile == 0.28 15:19:18 INFO - mozrunner == 6.11 15:19:18 INFO - mozscreenshot == 0.1 15:19:18 INFO - mozsystemmonitor == 0.3 15:19:18 INFO - moztest == 0.7 15:19:18 INFO - mozversion == 1.4 15:19:18 INFO - psutil == 3.1.1 15:19:18 INFO - requests == 1.2.3 15:19:18 INFO - wsgiref == 0.1.2 15:19:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:19:18 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')]} 15:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:18 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')]} 15:19:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:18 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 0x7f5531622f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f95450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20242c0>, '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 0x20251c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2025650>, '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': '3a3620fb28aea1604ab609ef000001d2-1467062741.3069-1424095623', '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 15:19:18 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 15:19:18 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 15:19:18 INFO - Using env: {'DISPLAY': ':0', 15:19:18 INFO - 'HOME': '/home/cltbld', 15:19:18 INFO - 'LANG': 'en_US.UTF-8', 15:19:18 INFO - 'LANGUAGE': 'en_US:en', 15:19:18 INFO - 'LOGNAME': 'cltbld', 15:19:18 INFO - 'MAIL': '/var/mail/cltbld', 15:19:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:18 INFO - 'MOZ_NO_REMOTE': '1', 15:19:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:18 INFO - 'NO_EM_RESTART': '1', 15:19:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:18 INFO - 'PWD': '/builds/slave/test', 15:19:18 INFO - 'SHELL': '/bin/bash', 15:19:18 INFO - 'SHLVL': '1', 15:19:18 INFO - 'TERM': 'linux', 15:19:18 INFO - 'TMOUT': '86400', 15:19:18 INFO - 'USER': 'cltbld', 15:19:18 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467062741.3069-1424095623', 15:19:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:18 INFO - '_': '/tools/buildbot/bin/python'} 15:19:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:19 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)) 15:19:19 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)) 15:19:19 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)) 15:19:19 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)) 15:19:19 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)) 15:19:19 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)) 15:19:19 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)) 15:19:19 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)) 15:19:19 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)) 15:19:19 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)) 15:19:19 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)) 15:19:19 INFO - Cleaning up... 15:19:19 INFO - Return code: 0 15:19:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:19:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:19:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5531622f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f95450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20242c0>, '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 0x20251c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2025650>, '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': '3a3620fb28aea1604ab609ef000001d2-1467062741.3069-1424095623', '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 15:19:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:19:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:19:19 INFO - Using env: {'DISPLAY': ':0', 15:19:19 INFO - 'HOME': '/home/cltbld', 15:19:19 INFO - 'LANG': 'en_US.UTF-8', 15:19:19 INFO - 'LANGUAGE': 'en_US:en', 15:19:19 INFO - 'LOGNAME': 'cltbld', 15:19:19 INFO - 'MAIL': '/var/mail/cltbld', 15:19:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:19 INFO - 'MOZ_NO_REMOTE': '1', 15:19:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:19 INFO - 'NO_EM_RESTART': '1', 15:19:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:19 INFO - 'PWD': '/builds/slave/test', 15:19:19 INFO - 'SHELL': '/bin/bash', 15:19:19 INFO - 'SHLVL': '1', 15:19:19 INFO - 'TERM': 'linux', 15:19:19 INFO - 'TMOUT': '86400', 15:19:19 INFO - 'USER': 'cltbld', 15:19:19 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467062741.3069-1424095623', 15:19:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:19 INFO - '_': '/tools/buildbot/bin/python'} 15:19:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:19:19 INFO - Cleaning up... 15:19:19 INFO - Return code: 0 15:19:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:19:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:19:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5531622f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f95450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20242c0>, '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 0x20251c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2025650>, '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': '3a3620fb28aea1604ab609ef000001d2-1467062741.3069-1424095623', '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 15:19:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:19:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:19:19 INFO - Using env: {'DISPLAY': ':0', 15:19:19 INFO - 'HOME': '/home/cltbld', 15:19:19 INFO - 'LANG': 'en_US.UTF-8', 15:19:19 INFO - 'LANGUAGE': 'en_US:en', 15:19:19 INFO - 'LOGNAME': 'cltbld', 15:19:19 INFO - 'MAIL': '/var/mail/cltbld', 15:19:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:19 INFO - 'MOZ_NO_REMOTE': '1', 15:19:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:19 INFO - 'NO_EM_RESTART': '1', 15:19:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:19 INFO - 'PWD': '/builds/slave/test', 15:19:19 INFO - 'SHELL': '/bin/bash', 15:19:19 INFO - 'SHLVL': '1', 15:19:19 INFO - 'TERM': 'linux', 15:19:19 INFO - 'TMOUT': '86400', 15:19:19 INFO - 'USER': 'cltbld', 15:19:19 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467062741.3069-1424095623', 15:19:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:19 INFO - '_': '/tools/buildbot/bin/python'} 15:19:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:19 INFO - Downloading/unpacking flake8 15:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:19:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:19:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:19:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:19:21 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 15:19:21 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 15:19:21 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 15:19:21 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 15:19:21 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 15:19:21 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 15:19:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:19:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:19:21 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 15:19:21 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 15:19:21 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 15:19:21 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 15:19:21 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 15:19:21 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 15:19:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:19:21 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 15:19:21 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 15:19:21 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 15:19:21 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 15:19:21 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 15:19:21 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 15:19:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:19:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:19:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:19:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:19:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:19:22 INFO - no previously-included directories found matching 'docs/_build' 15:19:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:19:22 INFO - Running setup.py install for pep8 15:19:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:19:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:19:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:19:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:19:22 INFO - no previously-included directories found matching 'docs/_build' 15:19:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:19:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:19:22 INFO - Cleaning up... 15:19:22 INFO - Return code: 0 15:19:22 INFO - Running post-action listener: _resource_record_post_action 15:19:22 INFO - Running post-action listener: _start_resource_monitoring 15:19:22 INFO - Starting resource monitoring. 15:19:22 INFO - ##### 15:19:22 INFO - ##### Finished create-virtualenv step (success) 15:19:22 INFO - ##### 15:19:22 INFO - ##### 15:19:22 INFO - ##### Running install step. 15:19:22 INFO - ##### 15:19:22 INFO - Running pre-action listener: _resource_record_pre_action 15:19:22 INFO - Running main action method: install 15:19:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:19:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:19:22 INFO - Reading from file tmpfile_stdout 15:19:22 INFO - Detecting whether we're running mozinstall >=1.0... 15:19:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:19:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:19:22 INFO - Reading from file tmpfile_stdout 15:19:22 INFO - Output received: 15:19:22 INFO - Usage: mozinstall [options] installer 15:19:22 INFO - Options: 15:19:22 INFO - -h, --help show this help message and exit 15:19:22 INFO - -d DEST, --destination=DEST 15:19:22 INFO - Directory to install application into. [default: 15:19:22 INFO - "/builds/slave/test"] 15:19:22 INFO - --app=APP Application being installed. [default: firefox] 15:19:22 INFO - mkdir: /builds/slave/test/build/application 15:19:22 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'] 15:19:22 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 15:19:38 INFO - Reading from file tmpfile_stdout 15:19:38 INFO - Output received: 15:19:38 INFO - /builds/slave/test/build/application/firefox/firefox 15:19:38 INFO - Running post-action listener: _resource_record_post_action 15:19:38 INFO - ##### 15:19:38 INFO - ##### Finished install step (success) 15:19:38 INFO - ##### 15:19:38 INFO - ##### 15:19:38 INFO - ##### Running run-tests step. 15:19:38 INFO - ##### 15:19:38 INFO - Running pre-action listener: _resource_record_pre_action 15:19:38 INFO - Running main action method: run_tests 15:19:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:19:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:19:38 INFO - Python 2.7.3 15:19:38 INFO - Return code: 0 15:19:38 INFO - grabbing minidump binary from tooltool 15:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:19:38 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 0x20242c0>, '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 0x20251c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2025650>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:19:38 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 15:19:38 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 15:19:38 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 15:19:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:19:38 INFO - Return code: 0 15:19:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:19:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:19:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:19:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:19:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:19:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:19:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:19:39 INFO - Return code: 0 15:19:39 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/DC-qWlWAQqmJie5ZmozaNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 15:19:39 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/DC-qWlWAQqmJie5ZmozaNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 15:19:39 INFO - Using env: {'DISPLAY': ':0', 15:19:39 INFO - 'HOME': '/home/cltbld', 15:19:39 INFO - 'LANG': 'en_US.UTF-8', 15:19:39 INFO - 'LANGUAGE': 'en_US:en', 15:19:39 INFO - 'LOGNAME': 'cltbld', 15:19:39 INFO - 'MAIL': '/var/mail/cltbld', 15:19:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:19:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:19:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:39 INFO - 'MOZ_NO_REMOTE': '1', 15:19:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:19:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:39 INFO - 'NO_EM_RESTART': '1', 15:19:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:39 INFO - 'PWD': '/builds/slave/test', 15:19:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:19:39 INFO - 'SHELL': '/bin/bash', 15:19:39 INFO - 'SHLVL': '1', 15:19:39 INFO - 'TERM': 'linux', 15:19:39 INFO - 'TMOUT': '86400', 15:19:39 INFO - 'USER': 'cltbld', 15:19:39 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467062741.3069-1424095623', 15:19:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:39 INFO - '_': '/tools/buildbot/bin/python'} 15:19:39 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/DC-qWlWAQqmJie5ZmozaNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 15:19:39 INFO - mozversion application_buildid: 20160627125116 15:19:39 INFO - mozversion application_changeset: f42e0b7e135a24347c414285ae531c879ee338d4 15:19:39 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:19:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:19:39 INFO - mozversion application_name: Firefox 15:19:39 INFO - mozversion application_remotingname: firefox-dev 15:19:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:19:39 INFO - mozversion application_vendor: Mozilla 15:19:39 INFO - mozversion application_version: 49.0a2 15:19:39 INFO - mozversion platform_buildid: 20160627125116 15:19:39 INFO - mozversion platform_changeset: f42e0b7e135a24347c414285ae531c879ee338d4 15:19:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:19:39 INFO - mozversion platform_version: 49.0a2 15:19:39 INFO - using testdate: 1467065979 15:19:39 INFO - actual date: 1467065979 15:19:39 INFO - starting webserver on 'localhost:40765' 15:19:39 INFO - SUITE-START | Running 2 tests 15:19:39 INFO - TEST-START | dromaeo_css 15:19:39 INFO - operating with platform_type : linux_ 15:19:39 INFO - Initialising browser for dromaeo_css test... 15:19:39 INFO - TEST-INFO | started process 3318 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjDC725/profile http://localhost:40765/getInfo.html) 15:19:46 INFO - PROCESS | 3318 | __metrics Screen width/height:1600/1200 15:19:46 INFO - PROCESS | 3318 | colorDepth:24 15:19:46 INFO - PROCESS | 3318 | Browser inner width/height: 1024/697 15:19:46 INFO - PROCESS | 3318 | __metrics 15:19:47 ERROR - PROCESS | 3318 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 15:19:48 INFO - TEST-INFO | 3318: exit 0 15:19:48 INFO - Browser initialized. 15:19:48 INFO - Running cycle 1/1 for dromaeo_css test... 15:19:48 INFO - TEST-INFO | started process 3449 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjDC725/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:20:00 INFO - PROCESS | 3449 | RSS: Main: 155992064 15:20:00 INFO - PROCESS | 3449 | 15:20:49 INFO - PROCESS | 3449 | 1467066049739 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] 15:22:58 INFO - PROCESS | 3449 | Cycle 1(1): loaded http://localhost:40765/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40765/tests/dromaeo/cssquery-ext.html) 15:22:59 INFO - PROCESS | 3449 | RSS: Main: 159322112 15:22:59 INFO - PROCESS | 3449 | 15:26:01 INFO - PROCESS | 3449 | Cycle 1(1): loaded http://localhost:40765/tests/dromaeo/cssquery-ext.html (next: http://localhost:40765/tests/dromaeo/cssquery-jquery.html) 15:26:01 INFO - PROCESS | 3449 | RSS: Main: 157536256 15:26:01 INFO - PROCESS | 3449 | 15:29:03 INFO - PROCESS | 3449 | Cycle 1(1): loaded http://localhost:40765/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40765/tests/dromaeo/cssquery-mootools.html) 15:29:04 INFO - PROCESS | 3449 | RSS: Main: 157487104 15:29:04 INFO - PROCESS | 3449 | 15:32:06 INFO - PROCESS | 3449 | Cycle 1(1): loaded http://localhost:40765/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40765/tests/dromaeo/cssquery-prototype.html) 15:32:06 INFO - PROCESS | 3449 | RSS: Main: 156680192 15:32:06 INFO - PROCESS | 3449 | 15:35:09 INFO - PROCESS | 3449 | Cycle 1(1): loaded http://localhost:40765/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40765/tests/dromaeo/cssquery-yui.html) 15:35:09 INFO - PROCESS | 3449 | RSS: Main: 159326208 15:35:09 INFO - PROCESS | 3449 | 15:38:11 INFO - PROCESS | 3449 | Cycle 1(1): loaded http://localhost:40765/tests/dromaeo/cssquery-yui.html (next: http://localhost:40765/tests/dromaeo/cssquery-dojo.html) 15:38:12 INFO - PROCESS | 3449 | RSS: Main: 159686656 15:38:12 INFO - PROCESS | 3449 | 15:38:12 INFO - PROCESS | 3449 | __start_tp_report 15:38:12 INFO - PROCESS | 3449 | _x_x_mozilla_page_load 15:38:12 INFO - PROCESS | 3449 | _x_x_mozilla_page_load_details 15:38:12 INFO - PROCESS | 3449 | |i|pagename|runs| 15:38:12 INFO - PROCESS | 3449 | |0;dojo.html;3408.6591340865907;3482.7039701625345;3492.1967947372095;3495.1611613212835;3499.562554680665;5813.563982701293;5825.038868586684;5825.883482330356;5865.090910908805;5918.496927761145;5894.823155305337;5923.73343199556;5929.28848538176;5930.347661757214;5937.67342796146;5211.661242019266;5273.129933560957;5278.445763194867;5297.099493086184;5323.893522129555;5111.463296353885;5144.0740666679985;5192.662476938987;5326.334208223972;5338.759755810978;5322.733863306838;5330.520253177213;5367.731613419333;5375.7849686012705;5386.272853164812;5363.812266570651;5381.757820898049;5431.4840090191365;5436.91844622331;5437.564994800446;5042.4201216860165;5139.537441630271;5285.7885684572575;5348.572114230852;5477.068898287261;5639.464250896158;5729.627574207705;5745.396733343023;5771.249737534094;5806.274215723035;6267.937320626781;6298.149749783766;6309.968450157766;6330.620162790247;6351.809445716636;6054.757809687607;6240.344763799781;6292.653904035276;6299.338569450233;6337.049442583603;5979.5814292999075;5988.520918326567;5990.311114221877;5994.370591087916;6003.909941350883;6500.999885299907;6535.248446428626;6536.542442029107;6541.640209788412;6559.6064236145985;5884.882302353929;6076.088586712029;6090.543209259324;6113.962834745899;6263.029230469194;6263.71813268404;6302.086197501429;6305.464035556937;6308.779192728232;6310.021946598285;6271;6286.9056964145575;6288.968555157195;6292.402221788922;6299;6028.608140470856;6100.359462256488;6117.632942023492;6129.148125236997;6229.3770622937345;4697.201475749131;4700.670953033323;4714;4716.174669432836;4744.1934871072;4117.423560701504;4195.202911446876;4206.179794940019;4215.22018426586;4237.87286381409;5769.394213607595;5899.144624029492;5986.2217911671205;6030.095485677183;6040.516758659297;6211.3167551569295;6223.751049958041;6313.210848643919;6313.305536390993;6325.873482530324;5759.596828222068;6005.6997150142315;6043.8489037773525;6049.576529642971;6057.575969682168;5301.098813201765;5346.037713211659;5367.490088441592;5410.945890541123;5456.48163424474;6531.0856480092825;6553.180852393451;6558.967205164039;6564.704588293538;6596.373344532261;6074.058520929263;6262.311145774052;6283.403076707706;6328.177336946167;6337.746490140527;6403.29563747978;6686.699098540675;6687.130673012477;6689.899651505329;6700.798976030532;6267.749290028348;6294.748210071546;6309.053641953744;6311.526635502264;6328.525360598066;6004.189434426471;6145.525073982123;6148;6406.263279722892;6423.871522569429;6110.419510146529;6112.052631842072;6112.229929638781;6133.431846319755;6138.5396095292135;6069.544784141295;6114.113453549299;6133.3866613338305;6133.969330153321;6143.324234334309;5818.6217895836635;5978.8206353809455;5982.371850955587;6040.607360521552;6046.667433291035;6158.475025239631;6221.595596286227;6257.530685198537;6264.2796078451565;6285.057241413824;6076.422739839708;6082.72627731762;6084.33072362031;6095.603785753912;6098.481629061579 15:38:12 INFO - PROCESS | 3449 | |1;ext.html;591.4529060618927;634.4828964394019;644.465093972003;661.9669016549173;678.1624693503526;43694.78152609237;47329.76335118328;47536.524634753645;47545;47732.522674773245;48358;48797.75601121989;49033.50966490334;49059.50940490594;49061.26408103881;9024.639014439415;9114.954425227865;9121.270298376114;9162.908370916271;9170.128837760401;8834.11658834118;8963.775905602346;8975.416597921147;8980.191782739552;9002.369834111614;8992.775180620503;9020.188183063523;9023.639054437816;9028.77428064297;9045.864312035324;8886.666999949995;8946.284297256268;8953.194212520872;8958.283337332998;8980.236679882219;8987.730368088967;9023.691564723078;9092.7272181834;9104.36269461138;9130.31522635805;44420.111597767864;44545.77727111376;44688.77655611734;44755.55244447546;44856.55143448556;3596.6942809861193;3698.8335524901445;3851.5955824638568;4059.6752259819145;4476.194285028693;34919.30161396783;34947.82526087379;34966.82516587426;35309.47035794465;36133.27733445343;4723.7638118093955;4739.431268247798;4786;4793.976030119862;4798.760061996886;360876;362449;362827;366480;368649.15675421717;38815;40165.79917100396;69003.65498172477;69646;70129;40791.7960410196;40940;40972.385414218814;40978;41309;16431.26059327333;16538.173091345383;16557.83442165587;16570.58573535671;16571.50285491437;13306.933465332611;13388.598342049754;13396.26320552379;13415.329233538285;13419.731605367839;9377.765555861159;9422.963474017852;9479.810403791886;9495.762605934908;9526.714198574055;3558.252766918976;3572.1783989682;3587.390143675529;3621.5473065866768;3630.455431685268;1120.9215354925077;1142.731458107344;1179.0920990837008;1203.4524291447372;1234.4321612058554;34413.827930860185;34436.82781586126;34921.65078349235;34988;35227;1205.4756181061266;1215.173681896319;1240.2124650846777;1266.8733126687257;1270.6823294176456;18039.188236529386;18069.186886589872;18088.457346279632;18387.172577234058;18477.81522184761;598146;602136;606594;608588;608797;66859;67124;67371;67501;67573.66213169001;1464.9047811892406;1499.700059987985;1502.3164460170597;1516.6132636177704;1534.0565552185326;33252.33495330128;33938.66061339355;33947;34062.829685851415;34080;58468;58480.4151958475;58585.70707146437;58639.120413192984;58659.70670146622;471025;475327;476270;476725;479885;31670.208244793143;32141.196470088435;32213.838930805196;32220.35559288848;32271;53494;54124.729376352865;54554.72722636361;55089.72455137699;55102;45705.771471142434;45996;46702.299465508724;46873;47376.289355659006;44600.33099503575;44912;45382;45457.31814022726;46910.765446172554;40105.1978960425;45802;46011.3098303519;47027;47115.76442117905;38283;39182.41226381664;40036.799816000734;40613.187736244516;40911;29622.259443514085;30399.39201215919;30551.388972220877;30903;31034.68965310318 15:38:12 INFO - PROCESS | 3449 | |2;jquery.html;429.2895258347435;433.70417476816317;435.32959242766134;438.29434610277445;442.6127138753591;18540;20363.694544581824;20602;21966.560668786613;21977.780222197773;19595.314164004263;19680.70478942817;20013.699794503093;20157.798422015774;20270.59458810823;5684.175794509804;5849.210356601847;5893.58744887858;5895.233619629442;5897.026990546576;5635;5824.737886795083;5833.912491312633;5846.766129354842;5894.351621321651;5779.133130030508;5787.508061814729;5787.855303617401;5806.535477161817;5832.154337621042;5567.66594004359;5709.457601527848;5714.342850572196;5720.084786434171;5780.53755699543;5075.619328550373;5111.437741848431;5126.71803050832;5135.35808023997;5137.434882162959;23978.28065158048;25076.49847003068;25106.748932510807;25146.874265628554;25284.494310113696;2463.741307162758;2517.6727025486753;2656.5218260713064;2808.050076061751;2931.4430258251077;14830.33263503145;15491.302891369804;15668.529944101696;15726.528204153894;15824.76262856058;2057.2593866208153;2068.493219161315;2098.3075585056895;2175.4670105824175;2220.8334374921947;83187.7521837173;85392;86168.13831861726;86609;86856.13143868544;11254.311853222081;11510.884891150981;11703.531858725726;11808.409579520989;11862.169648124549;16694.332226710794;16705.498835034967;16844.91577542129;16892.324307027582;16914.32342706278;8128.9593552031865;8694;8860.556972151368;8871.778205544913;8964.955175224082;8192.853000579924;8397.916020839713;8410.831783364298;8464.15358464161;8502.234798868009;5228.660137091077;5245.239440281138;5291.391489978625;5324.600654950894;5334.359876814807;2034.2168265217997;2173.0873033326043;2182.34529641107;2184.683220932956;2199.923002694898;947.7867479816986;977.7115750853516;1038.6312858934969;1088.9891101089047;1109.4175557832202;19363.128659210368;20038.68394616218;20211.898940505496;20304;20309.695354569692;1045.7385653586603;1056.102313033915;1060.4485667452882;1077.6928575355985;1080.486768784821;11067.667969960914;11441.54233830654;11448.427578621202;11470.36912969778;11478.19652624325;491885;502174;507636;512113;521976;74759;90403.54798225967;92324;95898.52050739701;96565;1016.070295679445;1034.715453250347;1045.6706137566794;1053.5680371047833;1060.9946950265198;18411.355602553846;18424.447266582025;18436.17037233301;18591.44225673232;18655.440336789918;43083.78458107689;43490.782546087066;45085;45111.32333014942;45476.31785523154;62803.37196627975;63023.36976630175;63085;64257.678711606146;64736.352636473035;9386.765330866783;9456;9464.432134071978;9467.952660236655;9486.762830929281;13371.732565348833;13699.589012329647;13711.794323084961;13764.724705505634;13815.930920345334;12392.504299828266;12512.499500020262;12561.183523070971;12668.809967850306;12715.17351372195;11915.82126268124;11967;12056.457459414523;12191.573294934635;12525;12120.27278363301;12354.938225308815;12500.312482813533;12636.620901372973;12698;9417.293702972442;9500;9510.95244523773;9524.285678573997;9663.13031827139;10623;11853.051755859684;11896.405179740805;12049.397530123633;12097.153199275966 15:38:12 INFO - PROCESS | 3449 | |3;mootools.html;1574.8031496062995;1618.1100394782866;1843.7787465504134;1929.8166674165966;1933.4586315831564;8747.300215982723;9378.390404623695;9400.952995235022;10176.99999999999;10185.439800810953;9484.952575237114;9787.21702263819;9836.704898853028;9840.901590984087;9853.7536561586;2509.3726568357865;2547.566913624679;2554.131595257612;2556.6931968163844;2558.3987762875804;2517.5342561626157;2560.654311667929;2570.4473538189286;2570.987145064272;2574.3049376668287;2487.3035550046015;2537.3402915242077;2567.9486410271784;2576.8196226264167;2577.3427775917116;2454.8158888083376;2482.5283196192754;2500.68741407325;2519.911803086883;2527.06498595519;2443.718972318188;2452.0314475782143;2453.153661986612;2470.1848390031428;2525.974740252611;9703.90296097037;9863.50682465881;9870.407775533491;9875.111239988435;9880.11079002886;5557.5831812613815;5686.914696279559;5710.65736055838;5711.628744131618;5714.342850572196;3661.8169091545315;3734.3651579231596;3817.366017447952;3869.28418242626;3910.7458015228917;1127.6504283672089;1173.683105561502;1176.6999415149169;1189.3280296632374;1198.5984695127142;14268.92865535676;14374.784378234335;14427;14443.133411995314;14465;5127.384713834289;5183.118869792144;5244.265802787613;5257.369115706063;5267.578593712494;12113.818292725617;12131.757364852654;12133.272003679807;12176;12190.268583884996;5928.644281343133;5930.52555795544;5935.614185077956;5949.970250148808;5967.850803729942;4699.271612899937;5414.91877621836;5439.728013599304;5484;5534.723263836872;4548;4574.245249533857;4609.792559334838;4610.2623580227;4687.273472611751;1430.6637940084072;1434.4047220403415;1448.160067161044;1451.5427640293274;1465.8607432293916;917.7476194046691;1040.6877936618985;1064.4039337970607;1070.0904231403244;1073.838924161382;6540.70566824494;6783.253842077367;6807.271857194754;6843.555168914005;6951.513394062367;475.5482291822782;477.3245857112217;482.50784200115686;491.665667346208;492.7536231884058;4591.357209990604;4700.741459219776;4703.247480403187;4732.621390288768;4741.502142275081;12181.69545761363;12528.310942898228;12589.055820813292;12605.180663256859;12621.432035558422;11885.821712674317;12362;12371.381430928597;12511.186772859735;12539.310337931502;8852.981907080639;8967.955160224288;8976.461412315282;9009.369344145978;9067.183953444222;6510.707018184288;6606.141201643755;6785.389314961677;6919.792406227822;6976.058232138596;11209.71975700614;11373.31760094397;11577.189596728149;11634;11690.064794816224;11545.191836571696;11664.533418663497;11670.94164529172;11797.17419780607;11978.700532486757;7944.920550794649;8473.152684731478;8590.871136933076;8654.264387527131;8789.912100879164;8925.776855578662;9134.995150533568;9150.679726209552;9172.082791720775;9239.676611318571;7802.336801371947;8056.5971701415865;8132.471389359673;8202.220789025034;8203.507789532647;7686.9231307686205;7851.9214807851195;7912.643931023233;8014.599270036359;8147.551884646401;7429.5542267464125;7446.553206807609;7479.775606731807;7540.359069479156;7553.962230188814;5303.946960530346;5394.56843452515;5555.388907220284;5568.805091821767;5836.066229403275;5472.124460086367;5474.534664553557;5556.749946252347;5581.023320918905;5779.219805326227 15:38:12 INFO - PROCESS | 3449 | |4;prototype.html;357.3032586456409;364.7811313212073;367.45433031947556;369.21910160011566;375.6337570868402;5722.914156287659;5761.971190144054;5841.18223448717;5897.85255368616;5971.8056388722325;5759.510441612458;5799.927013502494;5803.361630220672;5805.535557155428;5808.070708686611;4510.932336014962;4529.909401811962;4541.159885421192;4564.178447879389;4570.331828882468;4414.624756895668;4489.326601009859;4518.480374756912;4521.253993091153;4550.863474095782;4432.047109871377;4445.999650078723;4462.79917403716;4464.419625448687;4470.865874023784;4339.327404252346;4436.55634436557;4505.707129036635;4511.458624965009;4512.706674066191;3942.448057271984;3953.743006704584;3976.960230397688;3988.102676897704;3991.381335892941;5662.5933978059575;5670.943290567083;5671.574631902624;5682.346530149003;5684.2326285951285;5092.872678183038;5186.495916184302;5186.740662966837;5267.631265811395;5277.812492189265;6063.272407311107;6069.907416664999;6095.786647467317;6098.9695051524905;6144.815655530297;4374.737515749065;4405.757683327416;4412.4043254160915;4423.4912985006495;4426.800793964279;6200.441960223601;6381.351739028298;6383.968080159616;6423.8394040148905;6437.420632143129;4485.955140448619;4494.325851122358;4499.257622492252;4501.122281155209;4501.7524036177665;4470.754108524063;4515;4521.683482156283;4579.496255411902;4597.563231493003;4894.216925291937;5159.613029022838;5171.4828517148735;5215.322008138917;5228.37259528859;6022.006368949162;6137.84655383619;6156.322804491502;6161.876762464815;6168.228971378578;1536.2856271833427;1553.8601525862728;1565.3425561264296;1574.7480403135444;1577.4557777566722;986.6201512417771;990.5641517732319;1002.7665970855743;1011.8229309870743;1036.0882423467451;5331.760070796823;5348.411674715778;5386.946130538723;5411.053065713484;5425.37608175057;5564.610477266633;5586.776528938797;5608.943910560843;5636.943630563724;5663.490285874209;5288.92066619001;5348;5601.495865372054;5970.402959703995;6066.090086486974;3335.298997511287;3394.4229480988292;3397.9150521237166;3401;3427.1603457153155;6318.147050148263;6627.8459500662475;6648;6671.232808227116;6671.799846004627;6444.291127976013;6552.770653027121;6563.6389998549585;6575.276719560845;6607.638958287507;6192.628442293477;6633.2703402625675;6640.402363787186;6650.534462587572;6695.564788288746;6320.051992201206;6343.207099112611;6385.329540398191;6386.020333696569;6411.230652321751;6322.494200464043;6343.841403964938;6353.205849268841;6356.364363563606;6361.840953976002;6304.495640348669;6440.2915679276175;6523.032020430787;6544.574602650812;6566.704498297492;4428;4459.754713490789;4468.888277793081;4489.34904438861;4490.595846373842;6139.802738465956;6353.142325786144;6379.457746091634;6383.457406120532;6417.614943103429;6188.905547226387;6221.129041934223;6225.439710426083;6233.875322493615;6254.6247225166635;6051.848703782441;6170.81487555374;6192.473639740492;6194.101855230876;6268.905966410599;6165.5375846810775;6167.876642467036;6169.50643948474;6172.537059720449;6173.6167321200655;6155.599886007395;6231.626102433868;6252.531060170596;6322.272938612118;6331.620102793847;5823.883522329615;6025.367336429612;6074.1799857020505;6077.662914158878;6102.633841969318 15:38:12 INFO - PROCESS | 3449 | |5;yui.html;734.6143274780743;772.4592785050467;786.9965793613143;831.634081004358;875.1379890807556;14357.856421435783;16179.352825886965;16452.753208701863;16480.258388372524;16512.17439128045;15596.06423614584;15698.450554230605;15769.84230157698;15801.525954221363;15833.60415989598;727.4471401734693;842.4945032980194;872.7730789994615;873.388627960427;874.6501399440211;846.7036537211989;867.6139118092451;871.9520426376547;873.1574031060026;877.4296707140378;932.2588542109006;937.3906960475712;938.0572524612754;940.7507010642186;941.5339406993513;930.5765876526165;932.2495391210073;932.4545141092435;934.2525979216599;935.3265648732902;683.2518392360357;685.907402500661;688.0230073295882;689.3898899474002;690.9067275917737;15669.29488173035;15724.371025159095;15747.133907635076;15869.603259918478;15907.761383579256;13821.447142114303;13840.584782456543;13854.722905541832;14200.147991120462;14394;12843.357832108451;12968.416421261067;12997.610071697864;13071.41178646963;13426.127301725357;4626.930596041062;4633.397658304432;4643.6517261205545;4682.484926658065;4708.0819240248165;69178.65410672914;78598.21401786023;79463.20536794615;79955.6002219991;80043.19956800474;11787.35169565665;12258.26450412978;12315.4458049388;12561.183523070971;12735.68160795969;22537.43656408603;22546.54906901853;22583.322500325015;22585.435364116027;22590;9325.347225694137;9405.811883762286;9423.858642120374;9509.809803803884;9545.236381089497;4932.28481870134;4954.653174277838;5037.143685573461;5240.187770895517;5341.786328546892;3710.18375957289;3825.3305671507374;3827.2919509890758;3835.9424608630893;3850.2299540091535;628.7830698409042;636.4590098416309;637.4740838808002;637.6907200007993;648.3289795062088;606.9666168360694;789.4355535791937;795.6578671171336;803.6978017083513;809.287826712501;9676.95161524202;10654.733631659115;10700.678979630624;10723.892761072446;10724.14206863449;616.3497510126859;679.2697849811374;684.4455990647591;726.5023458930543;820.0897004325194;5097.490250974873;5282.2340760589495;5320.840374788762;5330.893382132335;5361.624686271924;108704.91295086948;119745.40127299308;121791.39104304422;121868.39065804791;124428;97742.02257977471;99149.00850991542;101387;101763.4911825451;102133.48933255287;59665;59766.70116649389;74848.62575687087;92051.99999999866;92096;9783.168430683187;9841.950790246003;9914.801703965735;9936.254780891317;10020.148287395654;55073;55541.0560630376;55724.442755573546;56672.43327566671;57173.42826571681;74215;80356;81156.59421702854;81298;81407;12551.93724031374;12566.685832854251;12725.55460558913;12759.936200319311;12921.676958076123;14225.217613030969;14498.275086245434;15018.849811502183;15158.242087895782;15347.693046138791;12820.743585128059;13783.931080344533;14452.710945780815;14897.329620167335;15288.617784555476;14465.78301325502;14566.85433145655;14799.260036998323;14862;15042.398304067714;11653.708657283296;11980.76038479243;12339.568115116286;13824.516141934984;13831.930840345734;12111.212771169845;12548.309842958724;12557.93721031389;12695.682607934876;13039.217646940835;11821.054315654555;12180.451879665614;12216.877831221575;12356.443960022001;12670.366481676063 15:38:12 INFO - PROCESS | 3449 | __end_tp_report 15:38:12 INFO - PROCESS | 3449 | __start_cc_report 15:38:12 INFO - PROCESS | 3449 | _x_x_mozilla_cycle_collect,338 15:38:12 INFO - PROCESS | 3449 | __end_cc_report 15:38:12 INFO - PROCESS | 3449 | __startTimestamp1467067092152__endTimestamp 15:38:12 INFO - PROCESS | 3449 | 15:38:12 INFO - PROCESS | 3449 | ------- Summary: start ------- 15:38:12 INFO - PROCESS | 3449 | Number of tests: 6 15:38:12 INFO - PROCESS | 3449 | 15:38:12 INFO - PROCESS | 3449 | [#0] dojo.html Cycles:165 Average:5830.18 Median:6054.76 stddev:679.72 (11.2%) stddev-sans-first:654.72 15:38:12 INFO - PROCESS | 3449 | Values: 3408.7 3482.7 3492.2 3495.2 3499.6 5813.6 5825.0 5825.9 5865.1 5918.5 5894.8 5923.7 5929.3 5930.3 5937.7 5211.7 5273.1 5278.4 5297.1 5323.9 5111.5 5144.1 5192.7 5326.3 5338.8 5322.7 5330.5 5367.7 5375.8 5386.3 5363.8 5381.8 5431.5 5436.9 5437.6 5042.4 5139.5 5285.8 5348.6 5477.1 5639.5 5729.6 5745.4 5771.2 5806.3 6267.9 6298.1 6310.0 6330.6 6351.8 6054.8 6240.3 6292.7 6299.3 6337.0 5979.6 5988.5 5990.3 5994.4 6003.9 6501.0 6535.2 6536.5 6541.6 6559.6 5884.9 6076.1 6090.5 6114.0 6263.0 6263.7 6302.1 6305.5 6308.8 6310.0 6271.0 6286.9 6289.0 6292.4 6299.0 6028.6 6100.4 6117.6 6129.1 6229.4 4697.2 4700.7 4714.0 4716.2 4744.2 4117.4 4195.2 4206.2 4215.2 4237.9 5769.4 5899.1 5986.2 6030.1 6040.5 6211.3 6223.8 6313.2 6313.3 6325.9 5759.6 6005.7 6043.8 6049.6 6057.6 5301.1 5346.0 5367.5 5410.9 5456.5 6531.1 6553.2 6559.0 6564.7 6596.4 6074.1 6262.3 6283.4 6328.2 6337.7 6403.3 6686.7 6687.1 6689.9 6700.8 6267.7 6294.7 6309.1 6311.5 6328.5 6004.2 6145.5 6148.0 6406.3 6423.9 6110.4 6112.1 6112.2 6133.4 6138.5 6069.5 6114.1 6133.4 6134.0 6143.3 5818.6 5978.8 5982.4 6040.6 6046.7 6158.5 6221.6 6257.5 6264.3 6285.1 6076.4 6082.7 6084.3 6095.6 6098.5 15:38:12 INFO - PROCESS | 3449 | 15:38:12 INFO - PROCESS | 3449 | [#1] ext.html Cycles:180 Average:64644.06 Median:45147.00 stddev:130750.73 (289.6%) stddev-sans-first:131029.08 15:38:12 INFO - PROCESS | 3449 | Values: 591.5 634.5 644.5 662.0 678.2 43694.8 47329.8 47536.5 47545.0 47732.5 48358.0 48797.8 49033.5 49059.5 49061.3 9024.6 9115.0 9121.3 9162.9 9170.1 8834.1 8963.8 8975.4 8980.2 9002.4 8992.8 9020.2 9023.6 9028.8 9045.9 8886.7 8946.3 8953.2 8958.3 8980.2 8987.7 9023.7 9092.7 9104.4 9130.3 44420.1 44545.8 44688.8 44755.6 44856.6 3596.7 3698.8 3851.6 4059.7 4476.2 34919.3 34947.8 34966.8 35309.5 36133.3 4723.8 4739.4 4786.0 4794.0 4798.8 360876.0 362449.0 362827.0 366480.0 368649.2 38815.0 40165.8 69003.7 69646.0 70129.0 40791.8 40940.0 40972.4 40978.0 41309.0 16431.3 16538.2 16557.8 16570.6 16571.5 13306.9 13388.6 13396.3 13415.3 13419.7 9377.8 9423.0 9479.8 9495.8 9526.7 3558.3 3572.2 3587.4 3621.5 3630.5 1120.9 1142.7 1179.1 1203.5 1234.4 34413.8 34436.8 34921.7 34988.0 35227.0 1205.5 1215.2 1240.2 1266.9 1270.7 18039.2 18069.2 18088.5 18387.2 18477.8 598146.0 602136.0 606594.0 608588.0 608797.0 66859.0 67124.0 67371.0 67501.0 67573.7 1464.9 1499.7 1502.3 1516.6 1534.1 33252.3 33938.7 33947.0 34062.8 34080.0 58468.0 58480.4 58585.7 58639.1 58659.7 471025.0 475327.0 476270.0 476725.0 479885.0 31670.2 32141.2 32213.8 32220.4 32271.0 53494.0 54124.7 54554.7 55089.7 55102.0 45705.8 45996.0 46702.3 46873.0 47376.3 44600.3 44912.0 45382.0 45457.3 46910.8 40105.2 45802.0 46011.3 47027.0 47115.8 38283.0 39182.4 40036.8 40613.2 40911.0 29622.3 30399.4 30551.4 30903.0 31034.7 15:38:12 INFO - PROCESS | 3449 | 15:38:12 INFO - PROCESS | 3449 | [#2] jquery.html Cycles:180 Average:30359.48 Median:25091.62 stddev:83556.62 (333.0%) stddev-sans-first:83760.79 15:38:12 INFO - PROCESS | 3449 | Values: 429.3 433.7 435.3 438.3 442.6 18540.0 20363.7 20602.0 21966.6 21977.8 19595.3 19680.7 20013.7 20157.8 20270.6 5684.2 5849.2 5893.6 5895.2 5897.0 5635.0 5824.7 5833.9 5846.8 5894.4 5779.1 5787.5 5787.9 5806.5 5832.2 5567.7 5709.5 5714.3 5720.1 5780.5 5075.6 5111.4 5126.7 5135.4 5137.4 23978.3 25076.5 25106.7 25146.9 25284.5 2463.7 2517.7 2656.5 2808.1 2931.4 14830.3 15491.3 15668.5 15726.5 15824.8 2057.3 2068.5 2098.3 2175.5 2220.8 83187.8 85392.0 86168.1 86609.0 86856.1 11254.3 11510.9 11703.5 11808.4 11862.2 16694.3 16705.5 16844.9 16892.3 16914.3 8129.0 8694.0 8860.6 8871.8 8965.0 8192.9 8397.9 8410.8 8464.2 8502.2 5228.7 5245.2 5291.4 5324.6 5334.4 2034.2 2173.1 2182.3 2184.7 2199.9 947.8 977.7 1038.6 1089.0 1109.4 19363.1 20038.7 20211.9 20304.0 20309.7 1045.7 1056.1 1060.4 1077.7 1080.5 11067.7 11441.5 11448.4 11470.4 11478.2 491885.0 502174.0 507636.0 512113.0 521976.0 74759.0 90403.5 92324.0 95898.5 96565.0 1016.1 1034.7 1045.7 1053.6 1061.0 18411.4 18424.4 18436.2 18591.4 18655.4 43083.8 43490.8 45085.0 45111.3 45476.3 62803.4 63023.4 63085.0 64257.7 64736.4 9386.8 9456.0 9464.4 9468.0 9486.8 13371.7 13699.6 13711.8 13764.7 13815.9 12392.5 12512.5 12561.2 12668.8 12715.2 11915.8 11967.0 12056.5 12191.6 12525.0 12120.3 12354.9 12500.3 12636.6 12698.0 9417.3 9500.0 9511.0 9524.3 9663.1 10623.0 11853.1 11896.4 12049.4 12097.2 15:38:12 INFO - PROCESS | 3449 | 15:38:12 INFO - PROCESS | 3449 | [#3] mootools.html Cycles:180 Average:6452.90 Median:4737.06 stddev:3784.16 (79.9%) stddev-sans-first:3777.02 15:38:12 INFO - PROCESS | 3449 | Values: 1574.8 1618.1 1843.8 1929.8 1933.5 8747.3 9378.4 9401.0 10177.0 10185.4 9485.0 9787.2 9836.7 9840.9 9853.8 2509.4 2547.6 2554.1 2556.7 2558.4 2517.5 2560.7 2570.4 2571.0 2574.3 2487.3 2537.3 2567.9 2576.8 2577.3 2454.8 2482.5 2500.7 2519.9 2527.1 2443.7 2452.0 2453.2 2470.2 2526.0 9703.9 9863.5 9870.4 9875.1 9880.1 5557.6 5686.9 5710.7 5711.6 5714.3 3661.8 3734.4 3817.4 3869.3 3910.7 1127.7 1173.7 1176.7 1189.3 1198.6 14268.9 14374.8 14427.0 14443.1 14465.0 5127.4 5183.1 5244.3 5257.4 5267.6 12113.8 12131.8 12133.3 12176.0 12190.3 5928.6 5930.5 5935.6 5950.0 5967.9 4699.3 5414.9 5439.7 5484.0 5534.7 4548.0 4574.2 4609.8 4610.3 4687.3 1430.7 1434.4 1448.2 1451.5 1465.9 917.7 1040.7 1064.4 1070.1 1073.8 6540.7 6783.3 6807.3 6843.6 6951.5 475.5 477.3 482.5 491.7 492.8 4591.4 4700.7 4703.2 4732.6 4741.5 12181.7 12528.3 12589.1 12605.2 12621.4 11885.8 12362.0 12371.4 12511.2 12539.3 8853.0 8968.0 8976.5 9009.4 9067.2 6510.7 6606.1 6785.4 6919.8 6976.1 11209.7 11373.3 11577.2 11634.0 11690.1 11545.2 11664.5 11670.9 11797.2 11978.7 7944.9 8473.2 8590.9 8654.3 8789.9 8925.8 9135.0 9150.7 9172.1 9239.7 7802.3 8056.6 8132.5 8202.2 8203.5 7686.9 7851.9 7912.6 8014.6 8147.6 7429.6 7446.6 7479.8 7540.4 7554.0 5303.9 5394.6 5555.4 5568.8 5836.1 5472.1 5474.5 5556.7 5581.0 5779.2 15:38:12 INFO - PROCESS | 3449 | 15:38:12 INFO - PROCESS | 3449 | [#4] prototype.html Cycles:180 Average:5142.25 Median:5703.57 stddev:1528.00 (26.8%) stddev-sans-first:1489.48 15:38:12 INFO - PROCESS | 3449 | Values: 357.3 364.8 367.5 369.2 375.6 5722.9 5762.0 5841.2 5897.9 5971.8 5759.5 5799.9 5803.4 5805.5 5808.1 4510.9 4529.9 4541.2 4564.2 4570.3 4414.6 4489.3 4518.5 4521.3 4550.9 4432.0 4446.0 4462.8 4464.4 4470.9 4339.3 4436.6 4505.7 4511.5 4512.7 3942.4 3953.7 3977.0 3988.1 3991.4 5662.6 5670.9 5671.6 5682.3 5684.2 5092.9 5186.5 5186.7 5267.6 5277.8 6063.3 6069.9 6095.8 6099.0 6144.8 4374.7 4405.8 4412.4 4423.5 4426.8 6200.4 6381.4 6384.0 6423.8 6437.4 4486.0 4494.3 4499.3 4501.1 4501.8 4470.8 4515.0 4521.7 4579.5 4597.6 4894.2 5159.6 5171.5 5215.3 5228.4 6022.0 6137.8 6156.3 6161.9 6168.2 1536.3 1553.9 1565.3 1574.7 1577.5 986.6 990.6 1002.8 1011.8 1036.1 5331.8 5348.4 5386.9 5411.1 5425.4 5564.6 5586.8 5608.9 5636.9 5663.5 5288.9 5348.0 5601.5 5970.4 6066.1 3335.3 3394.4 3397.9 3401.0 3427.2 6318.1 6627.8 6648.0 6671.2 6671.8 6444.3 6552.8 6563.6 6575.3 6607.6 6192.6 6633.3 6640.4 6650.5 6695.6 6320.1 6343.2 6385.3 6386.0 6411.2 6322.5 6343.8 6353.2 6356.4 6361.8 6304.5 6440.3 6523.0 6544.6 6566.7 4428.0 4459.8 4468.9 4489.3 4490.6 6139.8 6353.1 6379.5 6383.5 6417.6 6188.9 6221.1 6225.4 6233.9 6254.6 6051.8 6170.8 6192.5 6194.1 6268.9 6165.5 6167.9 6169.5 6172.5 6173.6 6155.6 6231.6 6252.5 6322.3 6331.6 5823.9 6025.4 6074.2 6077.7 6102.6 15:38:12 INFO - PROCESS | 3449 | 15:38:12 INFO - PROCESS | 3449 | [#5] yui.html Cycles:180 Average:21335.38 Median:4663.07 stddev:30301.09 (649.8%) stddev-sans-first:30346.61 15:38:12 INFO - PROCESS | 3449 | Values: 734.6 772.5 787.0 831.6 875.1 14357.9 16179.4 16452.8 16480.3 16512.2 15596.1 15698.5 15769.8 15801.5 15833.6 727.4 842.5 872.8 873.4 874.7 846.7 867.6 872.0 873.2 877.4 932.3 937.4 938.1 940.8 941.5 930.6 932.2 932.5 934.3 935.3 683.3 685.9 688.0 689.4 690.9 15669.3 15724.4 15747.1 15869.6 15907.8 13821.4 13840.6 13854.7 14200.1 14394.0 12843.4 12968.4 12997.6 13071.4 13426.1 4626.9 4633.4 4643.7 4682.5 4708.1 69178.7 78598.2 79463.2 79955.6 80043.2 11787.4 12258.3 12315.4 12561.2 12735.7 22537.4 22546.5 22583.3 22585.4 22590.0 9325.3 9405.8 9423.9 9509.8 9545.2 4932.3 4954.7 5037.1 5240.2 5341.8 3710.2 3825.3 3827.3 3835.9 3850.2 628.8 636.5 637.5 637.7 648.3 607.0 789.4 795.7 803.7 809.3 9677.0 10654.7 10700.7 10723.9 10724.1 616.3 679.3 684.4 726.5 820.1 5097.5 5282.2 5320.8 5330.9 5361.6 108704.9 119745.4 121791.4 121868.4 124428.0 97742.0 99149.0 101387.0 101763.5 102133.5 59665.0 59766.7 74848.6 92052.0 92096.0 9783.2 9842.0 9914.8 9936.3 10020.1 55073.0 55541.1 55724.4 56672.4 57173.4 74215.0 80356.0 81156.6 81298.0 81407.0 12551.9 12566.7 12725.6 12759.9 12921.7 14225.2 14498.3 15018.8 15158.2 15347.7 12820.7 13783.9 14452.7 14897.3 15288.6 14465.8 14566.9 14799.3 14862.0 15042.4 11653.7 11980.8 12339.6 13824.5 13831.9 12111.2 12548.3 12557.9 12695.7 13039.2 11821.1 12180.5 12216.9 12356.4 12670.4 15:38:12 INFO - PROCESS | 3449 | -------- Summary: end -------- 15:38:12 INFO - PROCESS | 3449 | 15:38:12 INFO - TEST-INFO | 3449: exit 0 15:38:12 INFO - TEST-OK | dromaeo_css | took 1112820ms 15:38:12 INFO - TEST-START | kraken 15:38:12 INFO - operating with platform_type : linux_ 15:38:12 INFO - Initialising browser for kraken test... 15:38:12 INFO - TEST-INFO | started process 3698 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqp7gH4/profile http://localhost:40765/getInfo.html) 15:38:17 INFO - PROCESS | 3698 | __metrics Screen width/height:1600/1200 15:38:17 INFO - PROCESS | 3698 | colorDepth:24 15:38:17 INFO - PROCESS | 3698 | Browser inner width/height: 1024/697 15:38:17 INFO - PROCESS | 3698 | __metrics 15:38:17 ERROR - PROCESS | 3698 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 15:38:18 INFO - TEST-INFO | 3698: exit 0 15:38:18 INFO - Browser initialized. 15:38:18 INFO - Running cycle 1/1 for kraken test... 15:38:18 INFO - TEST-INFO | started process 3828 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqp7gH4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:38:30 INFO - PROCESS | 3828 | RSS: Main: 156274688 15:38:30 INFO - PROCESS | 3828 | 15:38:32 INFO - PROCESS | 3828 | Cycle 1(1): loaded http://localhost:40765/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40765/tests/kraken/driver.html?testName=audio-beat-detection) 15:38:33 INFO - PROCESS | 3828 | RSS: Main: 161566720 15:38:33 INFO - PROCESS | 3828 | 15:38:36 INFO - PROCESS | 3828 | Cycle 1(1): loaded http://localhost:40765/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40765/tests/kraken/driver.html?testName=audio-dft) 15:38:36 INFO - PROCESS | 3828 | RSS: Main: 160485376 15:38:36 INFO - PROCESS | 3828 | 15:38:39 INFO - PROCESS | 3828 | Cycle 1(1): loaded http://localhost:40765/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40765/tests/kraken/driver.html?testName=audio-fft) 15:38:40 INFO - PROCESS | 3828 | RSS: Main: 161419264 15:38:40 INFO - PROCESS | 3828 | 15:38:42 INFO - PROCESS | 3828 | Cycle 1(1): loaded http://localhost:40765/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40765/tests/kraken/driver.html?testName=audio-oscillator) 15:38:43 INFO - PROCESS | 3828 | RSS: Main: 161439744 15:38:43 INFO - PROCESS | 3828 | 15:38:45 INFO - PROCESS | 3828 | Cycle 1(1): loaded http://localhost:40765/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40765/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:38:45 INFO - PROCESS | 3828 | RSS: Main: 161239040 15:38:45 INFO - PROCESS | 3828 | 15:38:48 INFO - PROCESS | 3828 | Cycle 1(1): loaded http://localhost:40765/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40765/tests/kraken/driver.html?testName=imaging-darkroom) 15:38:49 INFO - PROCESS | 3828 | RSS: Main: 160428032 15:38:49 INFO - PROCESS | 3828 | 15:38:52 INFO - PROCESS | 3828 | Cycle 1(1): loaded http://localhost:40765/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40765/tests/kraken/driver.html?testName=imaging-desaturate) 15:38:53 INFO - PROCESS | 3828 | RSS: Main: 161796096 15:38:53 INFO - PROCESS | 3828 | 15:38:56 INFO - PROCESS | 3828 | Cycle 1(1): loaded http://localhost:40765/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40765/tests/kraken/driver.html?testName=json-parse-financial) 15:38:57 INFO - PROCESS | 3828 | RSS: Main: 161419264 15:38:57 INFO - PROCESS | 3828 | 15:38:58 INFO - PROCESS | 3828 | Cycle 1(1): loaded http://localhost:40765/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40765/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:38:59 INFO - PROCESS | 3828 | RSS: Main: 161271808 15:38:59 INFO - PROCESS | 3828 | 15:39:00 INFO - PROCESS | 3828 | Cycle 1(1): loaded http://localhost:40765/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40765/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:39:01 INFO - PROCESS | 3828 | RSS: Main: 161390592 15:39:01 INFO - PROCESS | 3828 | 15:39:03 INFO - PROCESS | 3828 | Cycle 1(1): loaded http://localhost:40765/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40765/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:39:04 INFO - PROCESS | 3828 | RSS: Main: 161607680 15:39:04 INFO - PROCESS | 3828 | 15:39:07 INFO - PROCESS | 3828 | Cycle 1(1): loaded http://localhost:40765/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40765/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:39:07 INFO - PROCESS | 3828 | RSS: Main: 161779712 15:39:07 INFO - PROCESS | 3828 | 15:39:10 INFO - PROCESS | 3828 | Cycle 1(1): loaded http://localhost:40765/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40765/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:39:11 INFO - PROCESS | 3828 | RSS: Main: 161595392 15:39:11 INFO - PROCESS | 3828 | 15:39:12 INFO - PROCESS | 3828 | Cycle 1(1): loaded http://localhost:40765/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40765/tests/kraken/driver.html?testName=ai-astar) 15:39:12 INFO - PROCESS | 3828 | RSS: Main: 162459648 15:39:12 INFO - PROCESS | 3828 | 15:39:12 INFO - PROCESS | 3828 | __start_tp_report 15:39:12 INFO - PROCESS | 3828 | _x_x_mozilla_page_load 15:39:12 INFO - PROCESS | 3828 | _x_x_mozilla_page_load_details 15:39:12 INFO - PROCESS | 3828 | |i|pagename|runs| 15:39:12 INFO - PROCESS | 3828 | |0;ai-astar;115;105;110;110;110;110;111;109;110;110 15:39:12 INFO - PROCESS | 3828 | |1;audio-beat-detection;148;125;163;166;127;157;158;125;184;124 15:39:12 INFO - PROCESS | 3828 | |2;audio-dft;164;163;162;162;161;163;162;163;164;160 15:39:12 INFO - PROCESS | 3828 | |3;audio-fft;77;75;75;181;77;76;76;74;175;76 15:39:12 INFO - PROCESS | 3828 | |4;audio-oscillator;86;84;147;86;85;85;152;84;83;150 15:39:12 INFO - PROCESS | 3828 | |5;imaging-gaussian-blur;119;118;117;118;118;118;118;118;117;117 15:39:12 INFO - PROCESS | 3828 | |6;imaging-darkroom;149;150;149;149;148;151;148;150;149;147 15:39:12 INFO - PROCESS | 3828 | |7;imaging-desaturate;96;95;97;96;96;96;95;97;95;95 15:39:12 INFO - PROCESS | 3828 | |8;json-parse-financial;50;50;52;56;51;51;52;52;50;51 15:39:12 INFO - PROCESS | 3828 | |9;json-stringify-tinderbox;59;61;60;60;61;61;60;61;60;61 15:39:12 INFO - PROCESS | 3828 | |10;stanford-crypto-aes;80;79;77;78;77;81;78;78;102;78 15:39:12 INFO - PROCESS | 3828 | |11;stanford-crypto-ccm;119;119;119;121;125;121;119;128;120;128 15:39:12 INFO - PROCESS | 3828 | |12;stanford-crypto-pbkdf2;155;153;153;152;154;155;153;153;153;163 15:39:12 INFO - PROCESS | 3828 | |13;stanford-crypto-sha256-iterative;62;65;61;62;62;61;63;66;60;60 15:39:12 INFO - PROCESS | 3828 | __end_tp_report 15:39:12 INFO - PROCESS | 3828 | __start_cc_report 15:39:12 INFO - PROCESS | 3828 | _x_x_mozilla_cycle_collect,887 15:39:12 INFO - PROCESS | 3828 | __end_cc_report 15:39:12 INFO - PROCESS | 3828 | __startTimestamp1467067152923__endTimestamp 15:39:12 INFO - PROCESS | 3828 | 15:39:12 INFO - PROCESS | 3828 | ------- Summary: start ------- 15:39:12 INFO - PROCESS | 3828 | Number of tests: 14 15:39:12 INFO - PROCESS | 3828 | 15:39:12 INFO - PROCESS | 3828 | [#0] ai-astar Cycles:10 Average:110.00 Median:110.00 stddev:2.40 (2.2%) stddev-sans-first:1.74 15:39:12 INFO - PROCESS | 3828 | Values: 115.0 105.0 110.0 110.0 110.0 110.0 111.0 109.0 110.0 110.0 15:39:12 INFO - PROCESS | 3828 | 15:39:12 INFO - PROCESS | 3828 | [#1] audio-beat-detection Cycles:10 Average:147.70 Median:157.50 stddev:21.34 (13.6%) stddev-sans-first:22.64 15:39:12 INFO - PROCESS | 3828 | Values: 148.0 125.0 163.0 166.0 127.0 157.0 158.0 125.0 184.0 124.0 15:39:12 INFO - PROCESS | 3828 | 15:39:12 INFO - PROCESS | 3828 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:1.26 (0.8%) stddev-sans-first:1.20 15:39:12 INFO - PROCESS | 3828 | Values: 164.0 163.0 162.0 162.0 161.0 163.0 162.0 163.0 164.0 160.0 15:39:12 INFO - PROCESS | 3828 | 15:39:12 INFO - PROCESS | 3828 | [#3] audio-fft Cycles:10 Average:96.20 Median:76.00 stddev:43.15 (56.8%) stddev-sans-first:45.20 15:39:12 INFO - PROCESS | 3828 | Values: 77.0 75.0 75.0 181.0 77.0 76.0 76.0 74.0 175.0 76.0 15:39:12 INFO - PROCESS | 3828 | 15:39:12 INFO - PROCESS | 3828 | [#4] audio-oscillator Cycles:10 Average:104.20 Median:84.50 stddev:31.41 (37.2%) stddev-sans-first:32.62 15:39:12 INFO - PROCESS | 3828 | Values: 86.0 84.0 147.0 86.0 85.0 85.0 152.0 84.0 83.0 150.0 15:39:12 INFO - PROCESS | 3828 | 15:39:12 INFO - PROCESS | 3828 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.50 15:39:12 INFO - PROCESS | 3828 | Values: 119.0 118.0 117.0 118.0 118.0 118.0 118.0 118.0 117.0 117.0 15:39:12 INFO - PROCESS | 3828 | 15:39:12 INFO - PROCESS | 3828 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.00 stddev:1.15 (0.8%) stddev-sans-first:1.22 15:39:12 INFO - PROCESS | 3828 | Values: 149.0 150.0 149.0 149.0 148.0 151.0 148.0 150.0 149.0 147.0 15:39:12 INFO - PROCESS | 3828 | 15:39:12 INFO - PROCESS | 3828 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 15:39:12 INFO - PROCESS | 3828 | Values: 96.0 95.0 97.0 96.0 96.0 96.0 95.0 97.0 95.0 95.0 15:39:12 INFO - PROCESS | 3828 | 15:39:12 INFO - PROCESS | 3828 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:51.50 stddev:1.78 (3.5%) stddev-sans-first:1.80 15:39:12 INFO - PROCESS | 3828 | Values: 50.0 50.0 52.0 56.0 51.0 51.0 52.0 52.0 50.0 51.0 15:39:12 INFO - PROCESS | 3828 | 15:39:12 INFO - PROCESS | 3828 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:61.00 stddev:0.70 (1.1%) stddev-sans-first:0.53 15:39:12 INFO - PROCESS | 3828 | Values: 59.0 61.0 60.0 60.0 61.0 61.0 60.0 61.0 60.0 61.0 15:39:12 INFO - PROCESS | 3828 | 15:39:12 INFO - PROCESS | 3828 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:78.00 stddev:7.55 (9.7%) stddev-sans-first:8.01 15:39:12 INFO - PROCESS | 3828 | Values: 80.0 79.0 77.0 78.0 77.0 81.0 78.0 78.0 102.0 78.0 15:39:12 INFO - PROCESS | 3828 | 15:39:12 INFO - PROCESS | 3828 | [#11] stanford-crypto-ccm Cycles:10 Average:121.90 Median:121.00 stddev:3.70 (3.1%) stddev-sans-first:3.77 15:39:12 INFO - PROCESS | 3828 | Values: 119.0 119.0 119.0 121.0 125.0 121.0 119.0 128.0 120.0 128.0 15:39:12 INFO - PROCESS | 3828 | 15:39:12 INFO - PROCESS | 3828 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.40 Median:153.50 stddev:3.17 (2.1%) stddev-sans-first:3.35 15:39:12 INFO - PROCESS | 3828 | Values: 155.0 153.0 153.0 152.0 154.0 155.0 153.0 153.0 153.0 163.0 15:39:12 INFO - PROCESS | 3828 | 15:39:12 INFO - PROCESS | 3828 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:62.00 stddev:1.99 (3.2%) stddev-sans-first:2.11 15:39:12 INFO - PROCESS | 3828 | Values: 62.0 65.0 61.0 62.0 62.0 61.0 63.0 66.0 60.0 60.0 15:39:12 INFO - PROCESS | 3828 | -------- Summary: end -------- 15:39:12 INFO - PROCESS | 3828 | 15:39:13 INFO - TEST-INFO | 3828: exit 0 15:39:13 INFO - TEST-OK | kraken | took 61026ms 15:39:13 INFO - SUITE-END | took 1173s 15:39:14 INFO - Completed test suite (00:19:34) 15:39:14 INFO - javascript benchmark 15:39:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7759.352318232715, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3408.6591340865907, 3482.7039701625345, 3492.1967947372095, 3495.1611613212835, 3499.562554680665, 5813.563982701293, 5825.038868586684, 5825.883482330356, 5865.090910908805, 5918.496927761145, 5894.823155305337, 5923.73343199556, 5929.28848538176, 5930.347661757214, 5937.67342796146, 5211.661242019266, 5273.129933560957, 5278.445763194867, 5297.099493086184, 5323.893522129555, 5111.463296353885, 5144.0740666679985, 5192.662476938987, 5326.334208223972, 5338.759755810978, 5322.733863306838, 5330.520253177213, 5367.731613419333, 5375.7849686012705, 5386.272853164812, 5363.812266570651, 5381.757820898049, 5431.4840090191365, 5436.91844622331, 5437.564994800446, 5042.4201216860165, 5139.537441630271, 5285.7885684572575, 5348.572114230852, 5477.068898287261, 5639.464250896158, 5729.627574207705, 5745.396733343023, 5771.249737534094, 5806.274215723035, 6267.937320626781, 6298.149749783766, 6309.968450157766, 6330.620162790247, 6351.809445716636, 6054.757809687607, 6240.344763799781, 6292.653904035276, 6299.338569450233, 6337.049442583603, 5979.5814292999075, 5988.520918326567, 5990.311114221877, 5994.370591087916, 6003.909941350883, 6500.999885299907, 6535.248446428626, 6536.542442029107, 6541.640209788412, 6559.6064236145985, 5884.882302353929, 6076.088586712029, 6090.543209259324, 6113.962834745899, 6263.029230469194, 6263.71813268404, 6302.086197501429, 6305.464035556937, 6308.779192728232, 6310.021946598285, 6271.0, 6286.9056964145575, 6288.968555157195, 6292.402221788922, 6299.0, 6028.608140470856, 6100.359462256488, 6117.632942023492, 6129.148125236997, 6229.3770622937345, 4697.201475749131, 4700.670953033323, 4714.0, 4716.174669432836, 4744.1934871072, 4117.423560701504, 4195.202911446876, 4206.179794940019, 4215.22018426586, 4237.87286381409, 5769.394213607595, 5899.144624029492, 5986.2217911671205, 6030.095485677183, 6040.516758659297, 6211.3167551569295, 6223.751049958041, 6313.210848643919, 6313.305536390993, 6325.873482530324, 5759.596828222068, 6005.6997150142315, 6043.8489037773525, 6049.576529642971, 6057.575969682168, 5301.098813201765, 5346.037713211659, 5367.490088441592, 5410.945890541123, 5456.48163424474, 6531.0856480092825, 6553.180852393451, 6558.967205164039, 6564.704588293538, 6596.373344532261, 6074.058520929263, 6262.311145774052, 6283.403076707706, 6328.177336946167, 6337.746490140527, 6403.29563747978, 6686.699098540675, 6687.130673012477, 6689.899651505329, 6700.798976030532, 6267.749290028348, 6294.748210071546, 6309.053641953744, 6311.526635502264, 6328.525360598066, 6004.189434426471, 6145.525073982123, 6148.0, 6406.263279722892, 6423.871522569429, 6110.419510146529, 6112.052631842072, 6112.229929638781, 6133.431846319755, 6138.5396095292135, 6069.544784141295, 6114.113453549299, 6133.3866613338305, 6133.969330153321, 6143.324234334309, 5818.6217895836635, 5978.8206353809455, 5982.371850955587, 6040.607360521552, 6046.667433291035, 6158.475025239631, 6221.595596286227, 6257.530685198537, 6264.2796078451565, 6285.057241413824, 6076.422739839708, 6082.72627731762, 6084.33072362031, 6095.603785753912, 6098.481629061579], "value": 5783.969154791368, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.4529060618927, 634.4828964394019, 644.465093972003, 661.9669016549173, 678.1624693503526, 43694.78152609237, 47329.76335118328, 47536.524634753645, 47545.0, 47732.522674773245, 48358.0, 48797.75601121989, 49033.50966490334, 49059.50940490594, 49061.26408103881, 9024.639014439415, 9114.954425227865, 9121.270298376114, 9162.908370916271, 9170.128837760401, 8834.11658834118, 8963.775905602346, 8975.416597921147, 8980.191782739552, 9002.369834111614, 8992.775180620503, 9020.188183063523, 9023.639054437816, 9028.77428064297, 9045.864312035324, 8886.666999949995, 8946.284297256268, 8953.194212520872, 8958.283337332998, 8980.236679882219, 8987.730368088967, 9023.691564723078, 9092.7272181834, 9104.36269461138, 9130.31522635805, 44420.111597767864, 44545.77727111376, 44688.77655611734, 44755.55244447546, 44856.55143448556, 3596.6942809861193, 3698.8335524901445, 3851.5955824638568, 4059.6752259819145, 4476.194285028693, 34919.30161396783, 34947.82526087379, 34966.82516587426, 35309.47035794465, 36133.27733445343, 4723.7638118093955, 4739.431268247798, 4786.0, 4793.976030119862, 4798.760061996886, 360876.0, 362449.0, 362827.0, 366480.0, 368649.15675421717, 38815.0, 40165.79917100396, 69003.65498172477, 69646.0, 70129.0, 40791.7960410196, 40940.0, 40972.385414218814, 40978.0, 41309.0, 16431.26059327333, 16538.173091345383, 16557.83442165587, 16570.58573535671, 16571.50285491437, 13306.933465332611, 13388.598342049754, 13396.26320552379, 13415.329233538285, 13419.731605367839, 9377.765555861159, 9422.963474017852, 9479.810403791886, 9495.762605934908, 9526.714198574055, 3558.252766918976, 3572.1783989682, 3587.390143675529, 3621.5473065866768, 3630.455431685268, 1120.9215354925077, 1142.731458107344, 1179.0920990837008, 1203.4524291447372, 1234.4321612058554, 34413.827930860185, 34436.82781586126, 34921.65078349235, 34988.0, 35227.0, 1205.4756181061266, 1215.173681896319, 1240.2124650846777, 1266.8733126687257, 1270.6823294176456, 18039.188236529386, 18069.186886589872, 18088.457346279632, 18387.172577234058, 18477.81522184761, 598146.0, 602136.0, 606594.0, 608588.0, 608797.0, 66859.0, 67124.0, 67371.0, 67501.0, 67573.66213169001, 1464.9047811892406, 1499.700059987985, 1502.3164460170597, 1516.6132636177704, 1534.0565552185326, 33252.33495330128, 33938.66061339355, 33947.0, 34062.829685851415, 34080.0, 58468.0, 58480.4151958475, 58585.70707146437, 58639.120413192984, 58659.70670146622, 471025.0, 475327.0, 476270.0, 476725.0, 479885.0, 31670.208244793143, 32141.196470088435, 32213.838930805196, 32220.35559288848, 32271.0, 53494.0, 54124.729376352865, 54554.72722636361, 55089.72455137699, 55102.0, 45705.771471142434, 45996.0, 46702.299465508724, 46873.0, 47376.289355659006, 44600.33099503575, 44912.0, 45382.0, 45457.31814022726, 46910.765446172554, 40105.1978960425, 45802.0, 46011.3098303519, 47027.0, 47115.76442117905, 38283.0, 39182.41226381664, 40036.799816000734, 40613.187736244516, 40911.0, 29622.259443514085, 30399.39201215919, 30551.388972220877, 30903.0, 31034.68965310318], "value": 20549.03779736036, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.2895258347435, 433.70417476816317, 435.32959242766134, 438.29434610277445, 442.6127138753591, 18540.0, 20363.694544581824, 20602.0, 21966.560668786613, 21977.780222197773, 19595.314164004263, 19680.70478942817, 20013.699794503093, 20157.798422015774, 20270.59458810823, 5684.175794509804, 5849.210356601847, 5893.58744887858, 5895.233619629442, 5897.026990546576, 5635.0, 5824.737886795083, 5833.912491312633, 5846.766129354842, 5894.351621321651, 5779.133130030508, 5787.508061814729, 5787.855303617401, 5806.535477161817, 5832.154337621042, 5567.66594004359, 5709.457601527848, 5714.342850572196, 5720.084786434171, 5780.53755699543, 5075.619328550373, 5111.437741848431, 5126.71803050832, 5135.35808023997, 5137.434882162959, 23978.28065158048, 25076.49847003068, 25106.748932510807, 25146.874265628554, 25284.494310113696, 2463.741307162758, 2517.6727025486753, 2656.5218260713064, 2808.050076061751, 2931.4430258251077, 14830.33263503145, 15491.302891369804, 15668.529944101696, 15726.528204153894, 15824.76262856058, 2057.2593866208153, 2068.493219161315, 2098.3075585056895, 2175.4670105824175, 2220.8334374921947, 83187.7521837173, 85392.0, 86168.13831861726, 86609.0, 86856.13143868544, 11254.311853222081, 11510.884891150981, 11703.531858725726, 11808.409579520989, 11862.169648124549, 16694.332226710794, 16705.498835034967, 16844.91577542129, 16892.324307027582, 16914.32342706278, 8128.9593552031865, 8694.0, 8860.556972151368, 8871.778205544913, 8964.955175224082, 8192.853000579924, 8397.916020839713, 8410.831783364298, 8464.15358464161, 8502.234798868009, 5228.660137091077, 5245.239440281138, 5291.391489978625, 5324.600654950894, 5334.359876814807, 2034.2168265217997, 2173.0873033326043, 2182.34529641107, 2184.683220932956, 2199.923002694898, 947.7867479816986, 977.7115750853516, 1038.6312858934969, 1088.9891101089047, 1109.4175557832202, 19363.128659210368, 20038.68394616218, 20211.898940505496, 20304.0, 20309.695354569692, 1045.7385653586603, 1056.102313033915, 1060.4485667452882, 1077.6928575355985, 1080.486768784821, 11067.667969960914, 11441.54233830654, 11448.427578621202, 11470.36912969778, 11478.19652624325, 491885.0, 502174.0, 507636.0, 512113.0, 521976.0, 74759.0, 90403.54798225967, 92324.0, 95898.52050739701, 96565.0, 1016.070295679445, 1034.715453250347, 1045.6706137566794, 1053.5680371047833, 1060.9946950265198, 18411.355602553846, 18424.447266582025, 18436.17037233301, 18591.44225673232, 18655.440336789918, 43083.78458107689, 43490.782546087066, 45085.0, 45111.32333014942, 45476.31785523154, 62803.37196627975, 63023.36976630175, 63085.0, 64257.678711606146, 64736.352636473035, 9386.765330866783, 9456.0, 9464.432134071978, 9467.952660236655, 9486.762830929281, 13371.732565348833, 13699.589012329647, 13711.794323084961, 13764.724705505634, 13815.930920345334, 12392.504299828266, 12512.499500020262, 12561.183523070971, 12668.809967850306, 12715.17351372195, 11915.82126268124, 11967.0, 12056.457459414523, 12191.573294934635, 12525.0, 12120.27278363301, 12354.938225308815, 12500.312482813533, 12636.620901372973, 12698.0, 9417.293702972442, 9500.0, 9510.95244523773, 9524.285678573997, 9663.13031827139, 10623.0, 11853.051755859684, 11896.405179740805, 12049.397530123633, 12097.153199275966], "value": 9831.102744766566, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1574.8031496062995, 1618.1100394782866, 1843.7787465504134, 1929.8166674165966, 1933.4586315831564, 8747.300215982723, 9378.390404623695, 9400.952995235022, 10176.99999999999, 10185.439800810953, 9484.952575237114, 9787.21702263819, 9836.704898853028, 9840.901590984087, 9853.7536561586, 2509.3726568357865, 2547.566913624679, 2554.131595257612, 2556.6931968163844, 2558.3987762875804, 2517.5342561626157, 2560.654311667929, 2570.4473538189286, 2570.987145064272, 2574.3049376668287, 2487.3035550046015, 2537.3402915242077, 2567.9486410271784, 2576.8196226264167, 2577.3427775917116, 2454.8158888083376, 2482.5283196192754, 2500.68741407325, 2519.911803086883, 2527.06498595519, 2443.718972318188, 2452.0314475782143, 2453.153661986612, 2470.1848390031428, 2525.974740252611, 9703.90296097037, 9863.50682465881, 9870.407775533491, 9875.111239988435, 9880.11079002886, 5557.5831812613815, 5686.914696279559, 5710.65736055838, 5711.628744131618, 5714.342850572196, 3661.8169091545315, 3734.3651579231596, 3817.366017447952, 3869.28418242626, 3910.7458015228917, 1127.6504283672089, 1173.683105561502, 1176.6999415149169, 1189.3280296632374, 1198.5984695127142, 14268.92865535676, 14374.784378234335, 14427.0, 14443.133411995314, 14465.0, 5127.384713834289, 5183.118869792144, 5244.265802787613, 5257.369115706063, 5267.578593712494, 12113.818292725617, 12131.757364852654, 12133.272003679807, 12176.0, 12190.268583884996, 5928.644281343133, 5930.52555795544, 5935.614185077956, 5949.970250148808, 5967.850803729942, 4699.271612899937, 5414.91877621836, 5439.728013599304, 5484.0, 5534.723263836872, 4548.0, 4574.245249533857, 4609.792559334838, 4610.2623580227, 4687.273472611751, 1430.6637940084072, 1434.4047220403415, 1448.160067161044, 1451.5427640293274, 1465.8607432293916, 917.7476194046691, 1040.6877936618985, 1064.4039337970607, 1070.0904231403244, 1073.838924161382, 6540.70566824494, 6783.253842077367, 6807.271857194754, 6843.555168914005, 6951.513394062367, 475.5482291822782, 477.3245857112217, 482.50784200115686, 491.665667346208, 492.7536231884058, 4591.357209990604, 4700.741459219776, 4703.247480403187, 4732.621390288768, 4741.502142275081, 12181.69545761363, 12528.310942898228, 12589.055820813292, 12605.180663256859, 12621.432035558422, 11885.821712674317, 12362.0, 12371.381430928597, 12511.186772859735, 12539.310337931502, 8852.981907080639, 8967.955160224288, 8976.461412315282, 9009.369344145978, 9067.183953444222, 6510.707018184288, 6606.141201643755, 6785.389314961677, 6919.792406227822, 6976.058232138596, 11209.71975700614, 11373.31760094397, 11577.189596728149, 11634.0, 11690.064794816224, 11545.191836571696, 11664.533418663497, 11670.94164529172, 11797.17419780607, 11978.700532486757, 7944.920550794649, 8473.152684731478, 8590.871136933076, 8654.264387527131, 8789.912100879164, 8925.776855578662, 9134.995150533568, 9150.679726209552, 9172.082791720775, 9239.676611318571, 7802.336801371947, 8056.5971701415865, 8132.471389359673, 8202.220789025034, 8203.507789532647, 7686.9231307686205, 7851.9214807851195, 7912.643931023233, 8014.599270036359, 8147.551884646401, 7429.5542267464125, 7446.553206807609, 7479.775606731807, 7540.359069479156, 7553.962230188814, 5303.946960530346, 5394.56843452515, 5555.388907220284, 5568.805091821767, 5836.066229403275, 5472.124460086367, 5474.534664553557, 5556.749946252347, 5581.023320918905, 5779.219805326227], "value": 5035.636309282391, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.3032586456409, 364.7811313212073, 367.45433031947556, 369.21910160011566, 375.6337570868402, 5722.914156287659, 5761.971190144054, 5841.18223448717, 5897.85255368616, 5971.8056388722325, 5759.510441612458, 5799.927013502494, 5803.361630220672, 5805.535557155428, 5808.070708686611, 4510.932336014962, 4529.909401811962, 4541.159885421192, 4564.178447879389, 4570.331828882468, 4414.624756895668, 4489.326601009859, 4518.480374756912, 4521.253993091153, 4550.863474095782, 4432.047109871377, 4445.999650078723, 4462.79917403716, 4464.419625448687, 4470.865874023784, 4339.327404252346, 4436.55634436557, 4505.707129036635, 4511.458624965009, 4512.706674066191, 3942.448057271984, 3953.743006704584, 3976.960230397688, 3988.102676897704, 3991.381335892941, 5662.5933978059575, 5670.943290567083, 5671.574631902624, 5682.346530149003, 5684.2326285951285, 5092.872678183038, 5186.495916184302, 5186.740662966837, 5267.631265811395, 5277.812492189265, 6063.272407311107, 6069.907416664999, 6095.786647467317, 6098.9695051524905, 6144.815655530297, 4374.737515749065, 4405.757683327416, 4412.4043254160915, 4423.4912985006495, 4426.800793964279, 6200.441960223601, 6381.351739028298, 6383.968080159616, 6423.8394040148905, 6437.420632143129, 4485.955140448619, 4494.325851122358, 4499.257622492252, 4501.122281155209, 4501.7524036177665, 4470.754108524063, 4515.0, 4521.683482156283, 4579.496255411902, 4597.563231493003, 4894.216925291937, 5159.613029022838, 5171.4828517148735, 5215.322008138917, 5228.37259528859, 6022.006368949162, 6137.84655383619, 6156.322804491502, 6161.876762464815, 6168.228971378578, 1536.2856271833427, 1553.8601525862728, 1565.3425561264296, 1574.7480403135444, 1577.4557777566722, 986.6201512417771, 990.5641517732319, 1002.7665970855743, 1011.8229309870743, 1036.0882423467451, 5331.760070796823, 5348.411674715778, 5386.946130538723, 5411.053065713484, 5425.37608175057, 5564.610477266633, 5586.776528938797, 5608.943910560843, 5636.943630563724, 5663.490285874209, 5288.92066619001, 5348.0, 5601.495865372054, 5970.402959703995, 6066.090086486974, 3335.298997511287, 3394.4229480988292, 3397.9150521237166, 3401.0, 3427.1603457153155, 6318.147050148263, 6627.8459500662475, 6648.0, 6671.232808227116, 6671.799846004627, 6444.291127976013, 6552.770653027121, 6563.6389998549585, 6575.276719560845, 6607.638958287507, 6192.628442293477, 6633.2703402625675, 6640.402363787186, 6650.534462587572, 6695.564788288746, 6320.051992201206, 6343.207099112611, 6385.329540398191, 6386.020333696569, 6411.230652321751, 6322.494200464043, 6343.841403964938, 6353.205849268841, 6356.364363563606, 6361.840953976002, 6304.495640348669, 6440.2915679276175, 6523.032020430787, 6544.574602650812, 6566.704498297492, 4428.0, 4459.754713490789, 4468.888277793081, 4489.34904438861, 4490.595846373842, 6139.802738465956, 6353.142325786144, 6379.457746091634, 6383.457406120532, 6417.614943103429, 6188.905547226387, 6221.129041934223, 6225.439710426083, 6233.875322493615, 6254.6247225166635, 6051.848703782441, 6170.81487555374, 6192.473639740492, 6194.101855230876, 6268.905966410599, 6165.5375846810775, 6167.876642467036, 6169.50643948474, 6172.537059720449, 6173.6167321200655, 6155.599886007395, 6231.626102433868, 6252.531060170596, 6322.272938612118, 6331.620102793847, 5823.883522329615, 6025.367336429612, 6074.1799857020505, 6077.662914158878, 6102.633841969318], "value": 4654.9927031152465, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.6143274780743, 772.4592785050467, 786.9965793613143, 831.634081004358, 875.1379890807556, 14357.856421435783, 16179.352825886965, 16452.753208701863, 16480.258388372524, 16512.17439128045, 15596.06423614584, 15698.450554230605, 15769.84230157698, 15801.525954221363, 15833.60415989598, 727.4471401734693, 842.4945032980194, 872.7730789994615, 873.388627960427, 874.6501399440211, 846.7036537211989, 867.6139118092451, 871.9520426376547, 873.1574031060026, 877.4296707140378, 932.2588542109006, 937.3906960475712, 938.0572524612754, 940.7507010642186, 941.5339406993513, 930.5765876526165, 932.2495391210073, 932.4545141092435, 934.2525979216599, 935.3265648732902, 683.2518392360357, 685.907402500661, 688.0230073295882, 689.3898899474002, 690.9067275917737, 15669.29488173035, 15724.371025159095, 15747.133907635076, 15869.603259918478, 15907.761383579256, 13821.447142114303, 13840.584782456543, 13854.722905541832, 14200.147991120462, 14394.0, 12843.357832108451, 12968.416421261067, 12997.610071697864, 13071.41178646963, 13426.127301725357, 4626.930596041062, 4633.397658304432, 4643.6517261205545, 4682.484926658065, 4708.0819240248165, 69178.65410672914, 78598.21401786023, 79463.20536794615, 79955.6002219991, 80043.19956800474, 11787.35169565665, 12258.26450412978, 12315.4458049388, 12561.183523070971, 12735.68160795969, 22537.43656408603, 22546.54906901853, 22583.322500325015, 22585.435364116027, 22590.0, 9325.347225694137, 9405.811883762286, 9423.858642120374, 9509.809803803884, 9545.236381089497, 4932.28481870134, 4954.653174277838, 5037.143685573461, 5240.187770895517, 5341.786328546892, 3710.18375957289, 3825.3305671507374, 3827.2919509890758, 3835.9424608630893, 3850.2299540091535, 628.7830698409042, 636.4590098416309, 637.4740838808002, 637.6907200007993, 648.3289795062088, 606.9666168360694, 789.4355535791937, 795.6578671171336, 803.6978017083513, 809.287826712501, 9676.95161524202, 10654.733631659115, 10700.678979630624, 10723.892761072446, 10724.14206863449, 616.3497510126859, 679.2697849811374, 684.4455990647591, 726.5023458930543, 820.0897004325194, 5097.490250974873, 5282.2340760589495, 5320.840374788762, 5330.893382132335, 5361.624686271924, 108704.91295086948, 119745.40127299308, 121791.39104304422, 121868.39065804791, 124428.0, 97742.02257977471, 99149.00850991542, 101387.0, 101763.4911825451, 102133.48933255287, 59665.0, 59766.70116649389, 74848.62575687087, 92051.99999999866, 92096.0, 9783.168430683187, 9841.950790246003, 9914.801703965735, 9936.254780891317, 10020.148287395654, 55073.0, 55541.0560630376, 55724.442755573546, 56672.43327566671, 57173.42826571681, 74215.0, 80356.0, 81156.59421702854, 81298.0, 81407.0, 12551.93724031374, 12566.685832854251, 12725.55460558913, 12759.936200319311, 12921.676958076123, 14225.217613030969, 14498.275086245434, 15018.849811502183, 15158.242087895782, 15347.693046138791, 12820.743585128059, 13783.931080344533, 14452.710945780815, 14897.329620167335, 15288.617784555476, 14465.78301325502, 14566.85433145655, 14799.260036998323, 14862.0, 15042.398304067714, 11653.708657283296, 11980.76038479243, 12339.568115116286, 13824.516141934984, 13831.930840345734, 12111.212771169845, 12548.309842958724, 12557.93721031389, 12695.682607934876, 13039.217646940835, 11821.054315654555, 12180.451879665614, 12216.877831221575, 12356.443960022001, 12670.366481676063], "value": 7967.483313563025, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1514.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 105.0, 110.0, 110.0, 110.0, 110.0, 111.0, 109.0, 110.0, 110.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 125.0, 163.0, 166.0, 127.0, 157.0, 158.0, 125.0, 184.0, 124.0], "value": 147.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 162.0, 161.0, 163.0, 162.0, 163.0, 164.0, 160.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 181.0, 77.0, 76.0, 76.0, 74.0, 175.0, 76.0], "value": 96.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 147.0, 86.0, 85.0, 85.0, 152.0, 84.0, 83.0, 150.0], "value": 104.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 149.0, 149.0, 148.0, 151.0, 148.0, 150.0, 149.0, 147.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 97.0, 96.0, 96.0, 96.0, 95.0, 97.0, 95.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 52.0, 56.0, 51.0, 51.0, 52.0, 52.0, 50.0, 51.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 60.0, 60.0, 61.0, 61.0, 60.0, 61.0, 60.0, 61.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 77.0, 78.0, 77.0, 81.0, 78.0, 78.0, 102.0, 78.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 119.0, 121.0, 125.0, 121.0, 119.0, 128.0, 120.0, 128.0], "value": 121.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 153.0, 153.0, 152.0, 154.0, 155.0, 153.0, 153.0, 153.0, 163.0], "value": 154.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 61.0, 62.0, 62.0, 61.0, 63.0, 66.0, 60.0, 60.0], "value": 62.2, "unit": "score"}]}]} 15:39:14 INFO - Return code: 0 15:39:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:39:14 ERROR - # TBPL SUCCESS # 15:39:14 INFO - Running post-action listener: _resource_record_post_action 15:39:14 INFO - ##### 15:39:14 INFO - ##### Finished run-tests step (success) 15:39:14 INFO - ##### 15:39:14 INFO - Running post-run listener: _resource_record_post_run 15:39:14 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 7921664; Write bytes: 460701696; Read time: 1452; Write time: 384724 15:39:14 INFO - TinderboxPrint: CPU usage
13.3% 15:39:14 INFO - TinderboxPrint: I/O read bytes / time
7,921,664 / 1,452 15:39:14 INFO - TinderboxPrint: I/O write bytes / time
460,701,696 / 384,724 15:39:14 INFO - TinderboxPrint: CPU idle
8,233.5 (86.6%) 15:39:14 INFO - TinderboxPrint: CPU user
1,213.5 (12.8%) 15:39:14 INFO - TinderboxPrint: Swap in / out
0 / 0 15:39:14 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 84021248; Read time: 0; Write time: 47900 15:39:14 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 6160384; Write bytes: 376680448; Read time: 1412; Write time: 336824 15:39:14 INFO - Running post-run listener: _upload_blobber_files 15:39:14 INFO - Blob upload gear active. 15:39:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:39:14 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 15:39:14 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'] 15:39:14 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 15:39:15 INFO - (blobuploader) - INFO - Open directory for files ... 15:39:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:39:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:39:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:39:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:39:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:39:15 INFO - (blobuploader) - INFO - Done attempting. 15:39:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:39:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:39:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:39:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:39:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:39:19 INFO - (blobuploader) - INFO - Done attempting. 15:39:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:39:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:39:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:39:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:39:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:39:20 INFO - (blobuploader) - INFO - Done attempting. 15:39:20 INFO - (blobuploader) - INFO - Iteration through files over. 15:39:20 INFO - Return code: 0 15:39:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:39:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:39:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9bb22bed7f7dbc48d78e1624ca147e05d02743abf4fafb88c91292b4a747e235f62dd6e4dd41d0a54453d373d02acb1ce2efe308745e0761ab0d62eb576ae0ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3dd939c5449ddb0ec0d6d8e47711c4ace787b16d9a95b3962e1da9e2840d032d7e5a7b087a93af6f2258cc0948370a2edb9ecf40d1d9ce8489a3a5f86a5236ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a33f3e1cbecd8dff352099ee15afef03f56c45a494a05da955cc0be58e4ad0b0ded7b3593a7b4e816e2366f70a8d023d3ae07695d18aec614ef77e19ca0230f4"} 15:39:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:39:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:39:20 INFO - Contents: 15:39:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9bb22bed7f7dbc48d78e1624ca147e05d02743abf4fafb88c91292b4a747e235f62dd6e4dd41d0a54453d373d02acb1ce2efe308745e0761ab0d62eb576ae0ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3dd939c5449ddb0ec0d6d8e47711c4ace787b16d9a95b3962e1da9e2840d032d7e5a7b087a93af6f2258cc0948370a2edb9ecf40d1d9ce8489a3a5f86a5236ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a33f3e1cbecd8dff352099ee15afef03f56c45a494a05da955cc0be58e4ad0b0ded7b3593a7b4e816e2366f70a8d023d3ae07695d18aec614ef77e19ca0230f4"} 15:39:20 INFO - Running post-run listener: copy_logs_to_upload_dir 15:39:20 INFO - Copying logs to upload dir... 15:39:20 INFO - mkdir: /builds/slave/test/build/upload/logs 15:39:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.663406 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-27 15:39:20.142515) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 15:39:20.146623) ========= 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=3a3620fb28aea1604ab609ef000001d2-1467062741.3069-1424095623 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/9bb22bed7f7dbc48d78e1624ca147e05d02743abf4fafb88c91292b4a747e235f62dd6e4dd41d0a54453d373d02acb1ce2efe308745e0761ab0d62eb576ae0ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3dd939c5449ddb0ec0d6d8e47711c4ace787b16d9a95b3962e1da9e2840d032d7e5a7b087a93af6f2258cc0948370a2edb9ecf40d1d9ce8489a3a5f86a5236ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a33f3e1cbecd8dff352099ee15afef03f56c45a494a05da955cc0be58e4ad0b0ded7b3593a7b4e816e2366f70a8d023d3ae07695d18aec614ef77e19ca0230f4"} build_url:https://queue.taskcluster.net/v1/task/DC-qWlWAQqmJie5ZmozaNg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011272 build_url: 'https://queue.taskcluster.net/v1/task/DC-qWlWAQqmJie5ZmozaNg/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/9bb22bed7f7dbc48d78e1624ca147e05d02743abf4fafb88c91292b4a747e235f62dd6e4dd41d0a54453d373d02acb1ce2efe308745e0761ab0d62eb576ae0ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3dd939c5449ddb0ec0d6d8e47711c4ace787b16d9a95b3962e1da9e2840d032d7e5a7b087a93af6f2258cc0948370a2edb9ecf40d1d9ce8489a3a5f86a5236ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a33f3e1cbecd8dff352099ee15afef03f56c45a494a05da955cc0be58e4ad0b0ded7b3593a7b4e816e2366f70a8d023d3ae07695d18aec614ef77e19ca0230f4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 15:39:20.172737) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 15:39:20.173122) ========= 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=3a3620fb28aea1604ab609ef000001d2-1467062741.3069-1424095623 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 15:39:20.258675) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 15:39:20.259058) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 15:39:20.259415) ========= ========= Total master_lag: 0.17 =========