builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-018 starttime: 1468841074.57 results: success (0) buildid: 20160718014952 builduid: 8a32d47e896e4ed58b387a076dfe3c5e revision: c6dcf10108bdcb88f61533e589b4eb55255d38c1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 04:24:34.567389) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 04:24:34.567859) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 04:24:34.568136) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 04:24:34.639465) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 04:24:34.639800) ========= 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=62c568580acbfdaac3eec7be000001dc-1468841072.408528-2080761596 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-18 04:24: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% 13.3M=0.001s 2016-07-18 04:24:34 (13.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131865 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 04:24:34.784122) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 04:24:34.784450) ========= 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=62c568580acbfdaac3eec7be000001dc-1468841072.408528-2080761596 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.123741 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 04:24:34.918181) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 04:24:34.918660) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c6dcf10108bdcb88f61533e589b4eb55255d38c1 --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 c6dcf10108bdcb88f61533e589b4eb55255d38c1 --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=62c568580acbfdaac3eec7be000001dc-1468841072.408528-2080761596 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-18 04:24:34,952 truncating revision to first 12 chars 2016-07-18 04:24:34,952 Setting DEBUG logging. 2016-07-18 04:24:34,952 attempt 1/10 2016-07-18 04:24:34,952 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c6dcf10108bd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 04:24:35,301 unpacking tar archive at: mozilla-aurora-c6dcf10108bd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.707162 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 04:24:35.640763) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 04:24:35.641215) ========= script_repo_revision: c6dcf10108bdcb88f61533e589b4eb55255d38c1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 04:24:35.641724) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 04:24:35.642036) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 04:24:35.652993) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-18 04:24:35.653483) ========= /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=62c568580acbfdaac3eec7be000001dc-1468841072.408528-2080761596 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:24:35 INFO - MultiFileLogger online at 20160718 04:24:35 in /builds/slave/test 04:24: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 04:24:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:24:35 INFO - {'append_to_log': False, 04:24:35 INFO - 'base_work_dir': '/builds/slave/test', 04:24:35 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:24:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:24:35 INFO - 'branch': 'Mozilla-Aurora', 04:24:35 INFO - 'buildbot_json_path': 'buildprops.json', 04:24:35 INFO - 'config_files': ('talos/linux_config.py',), 04:24:35 INFO - 'default_actions': ('clobber', 04:24:35 INFO - 'read-buildbot-config', 04:24:35 INFO - 'download-and-extract', 04:24:35 INFO - 'populate-webroot', 04:24:35 INFO - 'create-virtualenv', 04:24:35 INFO - 'install', 04:24:35 INFO - 'run-tests'), 04:24:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:24:35 INFO - 'download_minidump_stackwalk': True, 04:24:35 INFO - 'download_symbols': 'ondemand', 04:24:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:24:35 INFO - 'tooltool.py': '/tools/tooltool.py', 04:24:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:24:35 INFO - '/tools/misc-python/virtualenv.py')}, 04:24:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:24:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:24:35 INFO - 'installer_path': 'installer.exe', 04:24:35 INFO - 'log_level': 'info', 04:24:35 INFO - 'log_name': 'talos', 04:24:35 INFO - 'log_to_console': True, 04:24:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:24:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:24:35 INFO - 'opt_config_files': (), 04:24:35 INFO - 'pip_index': False, 04:24:35 INFO - 'sps_profile': False, 04:24:35 INFO - 'sps_profile_interval': 0, 04:24:35 INFO - 'suite': 'dromaeojs-e10s', 04:24:35 INFO - 'system_bits': '32', 04:24:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:24:35 INFO - 'title': 'talos-linux64-ix-018', 04:24:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:24:35 INFO - 'use_talos_json': True, 04:24:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:24:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:24:35 INFO - 'work_dir': 'build'} 04:24:35 INFO - ##### 04:24:35 INFO - ##### Running clobber step. 04:24:35 INFO - ##### 04:24:35 INFO - Running pre-action listener: _resource_record_pre_action 04:24:35 INFO - Running main action method: clobber 04:24:35 INFO - rmtree: /builds/slave/test/build 04:24:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:24:37 INFO - Running post-action listener: _resource_record_post_action 04:24:37 INFO - ##### 04:24:37 INFO - ##### Finished clobber step (success) 04:24:37 INFO - ##### 04:24:37 INFO - ##### 04:24:37 INFO - ##### Running read-buildbot-config step. 04:24:37 INFO - ##### 04:24:37 INFO - Running pre-action listener: _resource_record_pre_action 04:24:37 INFO - Running main action method: read_buildbot_config 04:24:37 INFO - Using buildbot properties: 04:24:37 INFO - { 04:24:37 INFO - "project": "", 04:24:37 INFO - "product": "firefox", 04:24:37 INFO - "script_repo_revision": "production", 04:24:37 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 04:24:37 INFO - "repository": "", 04:24:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 04:24:37 INFO - "buildid": "20160718014952", 04:24:37 INFO - "pgo_build": "True", 04:24:37 INFO - "basedir": "/builds/slave/test", 04:24:37 INFO - "buildnumber": 452, 04:24:37 INFO - "slavename": "talos-linux64-ix-018", 04:24:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:24:37 INFO - "platform": "ubuntu64_hw", 04:24:37 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:24:37 INFO - "branch": "mozilla-aurora", 04:24:37 INFO - "repo_path": "releases/mozilla-aurora", 04:24:37 INFO - "revision": "c6dcf10108bdcb88f61533e589b4eb55255d38c1", 04:24:37 INFO - "stage_platform": "linux64-pgo", 04:24:37 INFO - "builduid": "8a32d47e896e4ed58b387a076dfe3c5e", 04:24:37 INFO - "slavebuilddir": "test" 04:24:37 INFO - } 04:24:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/W2CACFwkQ3ymcQtJCB-13Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 04:24:37 INFO - Running post-action listener: _resource_record_post_action 04:24:37 INFO - ##### 04:24:37 INFO - ##### Finished read-buildbot-config step (success) 04:24:37 INFO - ##### 04:24:37 INFO - ##### 04:24:37 INFO - ##### Running download-and-extract step. 04:24:37 INFO - ##### 04:24:37 INFO - Running pre-action listener: _resource_record_pre_action 04:24:37 INFO - Running main action method: download_and_extract 04:24:37 INFO - mkdir: /builds/slave/test/build/tests 04:24:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:37 INFO - https://queue.taskcluster.net/v1/task/W2CACFwkQ3ymcQtJCB-13Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:24:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W2CACFwkQ3ymcQtJCB-13Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:24:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W2CACFwkQ3ymcQtJCB-13Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:24:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W2CACFwkQ3ymcQtJCB-13Q/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 04:24:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W2CACFwkQ3ymcQtJCB-13Q/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 04:24:38 INFO - Downloaded 1361 bytes. 04:24:38 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:24:38 INFO - Using the following test package requirements: 04:24:38 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 04:24:38 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:24:38 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:24:38 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:24:38 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:24:38 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:24:38 INFO - u'jsshell-linux-x86_64.zip'], 04:24:38 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:24:38 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:24:38 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 04:24:38 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:24:38 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:24:38 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:24:38 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:24:38 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:24:38 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:24:38 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:24:38 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:24:38 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:24: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')]} 04:24:38 INFO - https://queue.taskcluster.net/v1/task/W2CACFwkQ3ymcQtJCB-13Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:24:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W2CACFwkQ3ymcQtJCB-13Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:24:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W2CACFwkQ3ymcQtJCB-13Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:24:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W2CACFwkQ3ymcQtJCB-13Q/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 04:24:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W2CACFwkQ3ymcQtJCB-13Q/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 04:24:40 INFO - Downloaded 24490914 bytes. 04:24:40 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'] 04:24:40 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 04:24:41 INFO - Return code: 0 04:24:41 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 04:24:41 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')]} 04:24:41 INFO - https://queue.taskcluster.net/v1/task/W2CACFwkQ3ymcQtJCB-13Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:24:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W2CACFwkQ3ymcQtJCB-13Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:24:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W2CACFwkQ3ymcQtJCB-13Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:24:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W2CACFwkQ3ymcQtJCB-13Q/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 04:24:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W2CACFwkQ3ymcQtJCB-13Q/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 04:24:42 INFO - Downloaded 24490914 bytes. 04:24:42 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'] 04:24:42 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 04:24:44 INFO - Return code: 0 04:24:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:44 INFO - https://queue.taskcluster.net/v1/task/W2CACFwkQ3ymcQtJCB-13Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:24:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W2CACFwkQ3ymcQtJCB-13Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 04:24:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W2CACFwkQ3ymcQtJCB-13Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 04:24:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W2CACFwkQ3ymcQtJCB-13Q/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 04:24:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W2CACFwkQ3ymcQtJCB-13Q/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 04:24:45 INFO - Downloaded 10833369 bytes. 04:24:45 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'] 04:24:45 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 04:24:45 INFO - Return code: 0 04:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:45 INFO - https://queue.taskcluster.net/v1/task/W2CACFwkQ3ymcQtJCB-13Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:24:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W2CACFwkQ3ymcQtJCB-13Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:24:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W2CACFwkQ3ymcQtJCB-13Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:24:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W2CACFwkQ3ymcQtJCB-13Q/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 04:24:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W2CACFwkQ3ymcQtJCB-13Q/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 04:24:48 INFO - Downloaded 63632800 bytes. 04:24:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W2CACFwkQ3ymcQtJCB-13Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:24:48 INFO - mkdir: /builds/slave/test/properties 04:24:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:24:48 INFO - Writing to file /builds/slave/test/properties/build_url 04:24:48 INFO - Contents: 04:24:48 INFO - build_url:https://queue.taskcluster.net/v1/task/W2CACFwkQ3ymcQtJCB-13Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:24:49 INFO - Running post-action listener: _resource_record_post_action 04:24:49 INFO - Running post-action listener: set_extra_try_arguments 04:24:49 INFO - ##### 04:24:49 INFO - ##### Finished download-and-extract step (success) 04:24:49 INFO - ##### 04:24:49 INFO - ##### 04:24:49 INFO - ##### Running populate-webroot step. 04:24:49 INFO - ##### 04:24:49 INFO - Running pre-action listener: _resource_record_pre_action 04:24:49 INFO - Running main action method: populate_webroot 04:24:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:24:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:24:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:24:49 INFO - '--tppagecycles', 04:24:49 INFO - '7'], 04:24:49 INFO - 'tests': ['tsvgm']}}, 04:24:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:24:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:24:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:24:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:24:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:24:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:24:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:49 INFO - 'talos_options': ['--disable-e10s'], 04:24:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:24:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:24:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:49 INFO - 'talos_options': ['--disable-e10s'], 04:24:49 INFO - 'tests': ['damp', 'tps']}, 04:24:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:49 INFO - 'tests': ['damp', 'tps']}, 04:24:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:24:49 INFO - 'tests': ['dromaeo_dom']}, 04:24:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:24:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:24:49 INFO - 'tests': ['a11yr', 04:24:49 INFO - 'ts_paint', 04:24:49 INFO - 'tpaint', 04:24:49 INFO - 'sessionrestore', 04:24:49 INFO - 'sessionrestore_no_auto_restore', 04:24:49 INFO - 'tabpaint']}, 04:24:49 INFO - 'other-e10s': {'tests': ['a11yr', 04:24:49 INFO - 'ts_paint', 04:24:49 INFO - 'tpaint', 04:24:49 INFO - 'sessionrestore', 04:24:49 INFO - 'sessionrestore_no_auto_restore', 04:24:49 INFO - 'tabpaint']}, 04:24:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:24:49 INFO - 'ts_paint', 04:24:49 INFO - 'tpaint', 04:24:49 INFO - 'sessionrestore', 04:24:49 INFO - 'sessionrestore_no_auto_restore', 04:24:49 INFO - 'tabpaint']}, 04:24:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:24:49 INFO - 'ts_paint', 04:24:49 INFO - 'tpaint', 04:24:49 INFO - 'sessionrestore', 04:24:49 INFO - 'sessionrestore_no_auto_restore', 04:24:49 INFO - 'tabpaint']}, 04:24:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:24:49 INFO - 'tests': ['a11yr', 04:24:49 INFO - 'ts_paint', 04:24:49 INFO - 'tpaint', 04:24:49 INFO - 'sessionrestore', 04:24:49 INFO - 'sessionrestore_no_auto_restore', 04:24:49 INFO - 'tabpaint']}, 04:24:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:24:49 INFO - 'tests': ['a11yr', 04:24:49 INFO - 'ts_paint', 04:24:49 INFO - 'tpaint', 04:24:49 INFO - 'sessionrestore', 04:24:49 INFO - 'sessionrestore_no_auto_restore', 04:24:49 INFO - 'tabpaint']}, 04:24:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:24:49 INFO - 'tests': ['tsvgx', 04:24:49 INFO - 'tsvgr_opacity', 04:24:49 INFO - 'tart', 04:24:49 INFO - 'tscrollx', 04:24:49 INFO - 'cart']}, 04:24:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:24:49 INFO - 'tsvgr_opacity', 04:24:49 INFO - 'tart', 04:24:49 INFO - 'tscrollx', 04:24:49 INFO - 'cart']}, 04:24:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:49 INFO - 'talos_options': ['--disable-e10s'], 04:24:49 INFO - 'tests': ['tp5o']}, 04:24:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:49 INFO - 'tests': ['tp5o']}, 04:24:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:49 INFO - 'talos_options': ['--disable-e10s', 04:24:49 INFO - '--xperf_path', 04:24:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:24:49 INFO - 'tests': ['tp5n']}, 04:24:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:49 INFO - 'talos_options': ['--xperf_path', 04:24:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:24:49 INFO - 'tests': ['tp5n']}}, 04:24:49 INFO - 'talos.zip': {'path': '', 04:24:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:24:49 INFO - Running post-action listener: _resource_record_post_action 04:24:49 INFO - ##### 04:24:49 INFO - ##### Finished populate-webroot step (success) 04:24:49 INFO - ##### 04:24:49 INFO - ##### 04:24:49 INFO - ##### Running create-virtualenv step. 04:24:49 INFO - ##### 04:24:49 INFO - Running pre-action listener: _resource_record_pre_action 04:24:49 INFO - Running main action method: create_virtualenv 04:24:49 INFO - Creating virtualenv /builds/slave/test/build/venv 04:24:49 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 04:24:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:24:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:24:53 INFO - Using real prefix '/usr' 04:24:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:24:54 INFO - Installing distribute.............................................................................................................................................................................................done. 04:24:56 INFO - Installing pip.................done. 04:24:56 INFO - Return code: 0 04:24:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe4c333f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1210350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129f1c0>, '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 0x12a00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a0550>, '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': '62c568580acbfdaac3eec7be000001dc-1468841072.408528-2080761596', '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 04:24:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:24:56 INFO - Using env: {'DISPLAY': ':0', 04:24:56 INFO - 'HOME': '/home/cltbld', 04:24:56 INFO - 'LANG': 'en_US.UTF-8', 04:24:56 INFO - 'LANGUAGE': 'en_US:en', 04:24:56 INFO - 'LOGNAME': 'cltbld', 04:24:56 INFO - 'MAIL': '/var/mail/cltbld', 04:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:56 INFO - 'MOZ_NO_REMOTE': '1', 04:24:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:56 INFO - 'NO_EM_RESTART': '1', 04:24:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:56 INFO - 'PWD': '/builds/slave/test', 04:24:56 INFO - 'SHELL': '/bin/bash', 04:24:56 INFO - 'SHLVL': '1', 04:24:56 INFO - 'TERM': 'linux', 04:24:56 INFO - 'TMOUT': '86400', 04:24:56 INFO - 'USER': 'cltbld', 04:24:56 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468841072.408528-2080761596', 04:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:56 INFO - '_': '/tools/buildbot/bin/python'} 04:24:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:56 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 04:24:56 INFO - Cleaning up... 04:24:56 INFO - Return code: 0 04:24:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffe4c333f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1210350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129f1c0>, '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 0x12a00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a0550>, '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': '62c568580acbfdaac3eec7be000001dc-1468841072.408528-2080761596', '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 04:24:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:24:56 INFO - Using env: {'DISPLAY': ':0', 04:24:56 INFO - 'HOME': '/home/cltbld', 04:24:56 INFO - 'LANG': 'en_US.UTF-8', 04:24:56 INFO - 'LANGUAGE': 'en_US:en', 04:24:56 INFO - 'LOGNAME': 'cltbld', 04:24:56 INFO - 'MAIL': '/var/mail/cltbld', 04:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:56 INFO - 'MOZ_NO_REMOTE': '1', 04:24:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:56 INFO - 'NO_EM_RESTART': '1', 04:24:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:56 INFO - 'PWD': '/builds/slave/test', 04:24:56 INFO - 'SHELL': '/bin/bash', 04:24:56 INFO - 'SHLVL': '1', 04:24:56 INFO - 'TERM': 'linux', 04:24:56 INFO - 'TMOUT': '86400', 04:24:56 INFO - 'USER': 'cltbld', 04:24:56 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468841072.408528-2080761596', 04:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:56 INFO - '_': '/tools/buildbot/bin/python'} 04:24:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:56 INFO - Downloading/unpacking psutil>=3.1.1 04:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:24:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:24:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:24:58 INFO - Installing collected packages: psutil 04:24:58 INFO - Running setup.py install for psutil 04:24:58 INFO - building 'psutil._psutil_linux' extension 04:24:58 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 04:25:00 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 04:25:00 INFO - building 'psutil._psutil_posix' extension 04:25:00 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 04:25:00 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 04:25:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:25:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:25:00 INFO - Successfully installed psutil 04:25:00 INFO - Cleaning up... 04:25:00 INFO - Return code: 0 04:25:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:25:00 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')]} 04:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:00 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')]} 04:25:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:00 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 0x7ffe4c333f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1210350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129f1c0>, '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 0x12a00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a0550>, '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': '62c568580acbfdaac3eec7be000001dc-1468841072.408528-2080761596', '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 04:25:00 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 04:25:00 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 04:25:00 INFO - Using env: {'DISPLAY': ':0', 04:25:00 INFO - 'HOME': '/home/cltbld', 04:25:00 INFO - 'LANG': 'en_US.UTF-8', 04:25:00 INFO - 'LANGUAGE': 'en_US:en', 04:25:00 INFO - 'LOGNAME': 'cltbld', 04:25:00 INFO - 'MAIL': '/var/mail/cltbld', 04:25:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:00 INFO - 'MOZ_NO_REMOTE': '1', 04:25:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:00 INFO - 'NO_EM_RESTART': '1', 04:25:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:00 INFO - 'PWD': '/builds/slave/test', 04:25:00 INFO - 'SHELL': '/bin/bash', 04:25:00 INFO - 'SHLVL': '1', 04:25:00 INFO - 'TERM': 'linux', 04:25:00 INFO - 'TMOUT': '86400', 04:25:00 INFO - 'USER': 'cltbld', 04:25:00 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468841072.408528-2080761596', 04:25:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:00 INFO - '_': '/tools/buildbot/bin/python'} 04:25:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:25:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:25:02 INFO - Installing collected packages: mozsystemmonitor 04:25:02 INFO - Running setup.py install for mozsystemmonitor 04:25:02 INFO - Successfully installed mozsystemmonitor 04:25:02 INFO - Cleaning up... 04:25:03 INFO - Return code: 0 04:25:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:25: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')]} 04:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25: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')]} 04:25:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25: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', '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 0x7ffe4c333f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1210350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129f1c0>, '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 0x12a00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a0550>, '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': '62c568580acbfdaac3eec7be000001dc-1468841072.408528-2080761596', '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 04:25: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:25: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 jsonschema==2.5.1 04:25:03 INFO - Using env: {'DISPLAY': ':0', 04:25:03 INFO - 'HOME': '/home/cltbld', 04:25:03 INFO - 'LANG': 'en_US.UTF-8', 04:25:03 INFO - 'LANGUAGE': 'en_US:en', 04:25:03 INFO - 'LOGNAME': 'cltbld', 04:25:03 INFO - 'MAIL': '/var/mail/cltbld', 04:25:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:03 INFO - 'MOZ_NO_REMOTE': '1', 04:25:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:03 INFO - 'NO_EM_RESTART': '1', 04:25:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:03 INFO - 'PWD': '/builds/slave/test', 04:25:03 INFO - 'SHELL': '/bin/bash', 04:25:03 INFO - 'SHLVL': '1', 04:25:03 INFO - 'TERM': 'linux', 04:25:03 INFO - 'TMOUT': '86400', 04:25:03 INFO - 'USER': 'cltbld', 04:25:03 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468841072.408528-2080761596', 04:25:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:03 INFO - '_': '/tools/buildbot/bin/python'} 04:25:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:03 INFO - Downloading/unpacking jsonschema==2.5.1 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:25:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:25:05 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 04:25:05 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 04:25:05 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 04:25:05 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 04:25:05 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 04:25:05 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 04:25:05 INFO - Downloading functools32-3.2.3-2.tar.gz 04:25:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:25:05 INFO - warning: no files found matching '*.txt' 04:25:05 INFO - no previously-included directories found matching 'build' 04:25:05 INFO - no previously-included directories found matching 'dist' 04:25:05 INFO - no previously-included directories found matching '.git*' 04:25:05 INFO - Installing collected packages: jsonschema, functools32 04:25:05 INFO - Running setup.py install for functools32 04:25:05 INFO - warning: no files found matching '*.txt' 04:25:05 INFO - no previously-included directories found matching 'build' 04:25:05 INFO - no previously-included directories found matching 'dist' 04:25:05 INFO - no previously-included directories found matching '.git*' 04:25:05 INFO - Successfully installed jsonschema functools32 04:25:05 INFO - Cleaning up... 04:25:05 INFO - Return code: 0 04:25:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:25: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')]} 04:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25: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')]} 04:25:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25: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', '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 0x7ffe4c333f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1210350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129f1c0>, '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 0x12a00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a0550>, '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': '62c568580acbfdaac3eec7be000001dc-1468841072.408528-2080761596', '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 04:25: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:25: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 blobuploader==1.2.4 04:25:05 INFO - Using env: {'DISPLAY': ':0', 04:25:05 INFO - 'HOME': '/home/cltbld', 04:25:05 INFO - 'LANG': 'en_US.UTF-8', 04:25:05 INFO - 'LANGUAGE': 'en_US:en', 04:25:05 INFO - 'LOGNAME': 'cltbld', 04:25:05 INFO - 'MAIL': '/var/mail/cltbld', 04:25:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:05 INFO - 'MOZ_NO_REMOTE': '1', 04:25:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:05 INFO - 'NO_EM_RESTART': '1', 04:25:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:05 INFO - 'PWD': '/builds/slave/test', 04:25:05 INFO - 'SHELL': '/bin/bash', 04:25:05 INFO - 'SHLVL': '1', 04:25:05 INFO - 'TERM': 'linux', 04:25:05 INFO - 'TMOUT': '86400', 04:25:05 INFO - 'USER': 'cltbld', 04:25:05 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468841072.408528-2080761596', 04:25:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:05 INFO - '_': '/tools/buildbot/bin/python'} 04:25:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:05 INFO - Downloading/unpacking blobuploader==1.2.4 04:25:05 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 04:25:05 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 04:25:05 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 04:25:05 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 04:25:05 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 04:25:05 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 04:25:07 INFO - Downloading blobuploader-1.2.4.tar.gz 04:25:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:25:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:25:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25:08 INFO - Downloading docopt-0.6.1.tar.gz 04:25:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:25:08 INFO - Installing collected packages: blobuploader, requests, docopt 04:25:08 INFO - Running setup.py install for blobuploader 04:25:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:25:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:25:08 INFO - Running setup.py install for requests 04:25:09 INFO - Running setup.py install for docopt 04:25:09 INFO - Successfully installed blobuploader requests docopt 04:25:09 INFO - Cleaning up... 04:25:09 INFO - Return code: 0 04:25:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25:09 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')]} 04:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:09 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')]} 04:25:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:09 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 0x7ffe4c333f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1210350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129f1c0>, '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 0x12a00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a0550>, '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': '62c568580acbfdaac3eec7be000001dc-1468841072.408528-2080761596', '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 04:25:09 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 04:25:09 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 04:25:09 INFO - Using env: {'DISPLAY': ':0', 04:25:09 INFO - 'HOME': '/home/cltbld', 04:25:09 INFO - 'LANG': 'en_US.UTF-8', 04:25:09 INFO - 'LANGUAGE': 'en_US:en', 04:25:09 INFO - 'LOGNAME': 'cltbld', 04:25:09 INFO - 'MAIL': '/var/mail/cltbld', 04:25:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:09 INFO - 'MOZ_NO_REMOTE': '1', 04:25:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:09 INFO - 'NO_EM_RESTART': '1', 04:25:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:09 INFO - 'PWD': '/builds/slave/test', 04:25:09 INFO - 'SHELL': '/bin/bash', 04:25:09 INFO - 'SHLVL': '1', 04:25:09 INFO - 'TERM': 'linux', 04:25:09 INFO - 'TMOUT': '86400', 04:25:09 INFO - 'USER': 'cltbld', 04:25:09 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468841072.408528-2080761596', 04:25:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:09 INFO - '_': '/tools/buildbot/bin/python'} 04:25:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:25:09 INFO - Running setup.py (path:/tmp/pip-BgbwoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:25:09 INFO - Running setup.py (path:/tmp/pip-kCJzTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:25:09 INFO - Running setup.py (path:/tmp/pip-5QYPNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:25:09 INFO - Running setup.py (path:/tmp/pip-XD_TCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:25:09 INFO - Running setup.py (path:/tmp/pip-pNBvo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:25:09 INFO - Running setup.py (path:/tmp/pip-vNBR0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:25:09 INFO - Running setup.py (path:/tmp/pip-ZAS3kt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:25:09 INFO - Running setup.py (path:/tmp/pip-LZ0vt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:25:09 INFO - Running setup.py (path:/tmp/pip-jhdiPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:25:10 INFO - Running setup.py (path:/tmp/pip-Tg0GSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:25:10 INFO - Running setup.py (path:/tmp/pip-JIF47W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:25:10 INFO - Running setup.py (path:/tmp/pip-h3lKK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:25:10 INFO - Running setup.py (path:/tmp/pip-aRBZx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:25:10 INFO - Running setup.py (path:/tmp/pip-sRrj4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:10 INFO - Running setup.py (path:/tmp/pip-nYN3FP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:25:10 INFO - Running setup.py (path:/tmp/pip-CwfSDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:25:10 INFO - Running setup.py (path:/tmp/pip-tfXuZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:25:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:25:10 INFO - Running setup.py install for manifestparser 04:25:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:25:10 INFO - Running setup.py install for mozcrash 04:25:10 INFO - Running setup.py install for mozdebug 04:25:10 INFO - Running setup.py install for mozdevice 04:25:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:25:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:25:11 INFO - Running setup.py install for mozfile 04:25:11 INFO - Running setup.py install for mozhttpd 04:25:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:25:11 INFO - Running setup.py install for mozinfo 04:25:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:25:11 INFO - Running setup.py install for mozInstall 04:25:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:25:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:25:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:25:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:25:11 INFO - Running setup.py install for mozleak 04:25:11 INFO - Running setup.py install for mozlog 04:25:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:25:11 INFO - Running setup.py install for moznetwork 04:25:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:25:11 INFO - Running setup.py install for mozprocess 04:25:11 INFO - Running setup.py install for mozprofile 04:25:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:25:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:25:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:25:12 INFO - Running setup.py install for mozrunner 04:25:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:25:12 INFO - Running setup.py install for mozscreenshot 04:25:12 INFO - Running setup.py install for moztest 04:25:12 INFO - Running setup.py install for mozversion 04:25:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:25:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:25:12 INFO - Cleaning up... 04:25:12 INFO - Return code: 0 04:25:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:12 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 0x7ffe4c333f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1210350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129f1c0>, '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 0x12a00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a0550>, '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': '62c568580acbfdaac3eec7be000001dc-1468841072.408528-2080761596', '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 04:25:12 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 04:25:12 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 04:25:12 INFO - Using env: {'DISPLAY': ':0', 04:25:12 INFO - 'HOME': '/home/cltbld', 04:25:12 INFO - 'LANG': 'en_US.UTF-8', 04:25:12 INFO - 'LANGUAGE': 'en_US:en', 04:25:12 INFO - 'LOGNAME': 'cltbld', 04:25:12 INFO - 'MAIL': '/var/mail/cltbld', 04:25:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:12 INFO - 'MOZ_NO_REMOTE': '1', 04:25:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:12 INFO - 'NO_EM_RESTART': '1', 04:25:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:12 INFO - 'PWD': '/builds/slave/test', 04:25:12 INFO - 'SHELL': '/bin/bash', 04:25:12 INFO - 'SHLVL': '1', 04:25:12 INFO - 'TERM': 'linux', 04:25:12 INFO - 'TMOUT': '86400', 04:25:12 INFO - 'USER': 'cltbld', 04:25:12 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468841072.408528-2080761596', 04:25:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:12 INFO - '_': '/tools/buildbot/bin/python'} 04:25:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:25:12 INFO - Running setup.py (path:/tmp/pip-Kbf5cF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:25:12 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)) 04:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:25:12 INFO - Running setup.py (path:/tmp/pip-6WDALQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:25:12 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)) 04:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:25:12 INFO - Running setup.py (path:/tmp/pip-RZdhF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:25:12 INFO - Running setup.py (path:/tmp/pip-ISZQoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:25:12 INFO - Running setup.py (path:/tmp/pip-QuUlSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:25:13 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)) 04:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:25:13 INFO - Running setup.py (path:/tmp/pip-3DaJkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:25:13 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)) 04:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:25:13 INFO - Running setup.py (path:/tmp/pip-NCwuaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:25:13 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)) 04:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:25:13 INFO - Running setup.py (path:/tmp/pip-Y8zM6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:25:13 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)) 04:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:25:13 INFO - Running setup.py (path:/tmp/pip-dwQTc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:25:13 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)) 04:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:25:13 INFO - Running setup.py (path:/tmp/pip-HusbWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:25:13 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)) 04:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:25:13 INFO - Running setup.py (path:/tmp/pip-nYgixo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:25:13 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)) 04:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:25:13 INFO - Running setup.py (path:/tmp/pip-jQ7x8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:25:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:25:13 INFO - Running setup.py (path:/tmp/pip-E2wLGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:25:13 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)) 04:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:25:13 INFO - Running setup.py (path:/tmp/pip-Mu_pZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:25:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:13 INFO - Running setup.py (path:/tmp/pip-RR3NYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:13 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)) 04:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:25:13 INFO - Running setup.py (path:/tmp/pip-vTd4bY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:25:13 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)) 04:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:25:13 INFO - Running setup.py (path:/tmp/pip-eM0LEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:25:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:25:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:25:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:25:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:25:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:25:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:25:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:15 INFO - Downloading blessings-1.6.tar.gz 04:25:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:25:15 INFO - Installing collected packages: blessings 04:25:15 INFO - Running setup.py install for blessings 04:25:16 INFO - Successfully installed blessings 04:25:16 INFO - Cleaning up... 04:25:16 INFO - Return code: 0 04:25:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:25:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:25:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:25:16 INFO - Reading from file tmpfile_stdout 04:25:16 INFO - Current package versions: 04:25:16 INFO - argparse == 1.2.1 04:25:16 INFO - blessings == 1.6 04:25:16 INFO - blobuploader == 1.2.4 04:25:16 INFO - docopt == 0.6.1 04:25:16 INFO - functools32 == 3.2.3-2 04:25:16 INFO - jsonschema == 2.5.1 04:25:16 INFO - manifestparser == 1.1 04:25:16 INFO - mozInstall == 1.12 04:25:16 INFO - mozcrash == 0.17 04:25:16 INFO - mozdebug == 0.1 04:25:16 INFO - mozdevice == 0.48 04:25:16 INFO - mozfile == 1.2 04:25:16 INFO - mozhttpd == 0.7 04:25:16 INFO - mozinfo == 0.9 04:25:16 INFO - mozleak == 0.1 04:25:16 INFO - mozlog == 3.2 04:25:16 INFO - moznetwork == 0.27 04:25:16 INFO - mozprocess == 0.23 04:25:16 INFO - mozprofile == 0.28 04:25:16 INFO - mozrunner == 6.12 04:25:16 INFO - mozscreenshot == 0.1 04:25:16 INFO - mozsystemmonitor == 0.3 04:25:16 INFO - moztest == 0.7 04:25:16 INFO - mozversion == 1.4 04:25:16 INFO - psutil == 3.1.1 04:25:16 INFO - requests == 1.2.3 04:25:16 INFO - wsgiref == 0.1.2 04:25:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25:16 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')]} 04:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:16 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')]} 04:25:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:16 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 0x7ffe4c333f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1210350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129f1c0>, '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 0x12a00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a0550>, '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': '62c568580acbfdaac3eec7be000001dc-1468841072.408528-2080761596', '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 04:25:16 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 04:25:16 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 04:25:16 INFO - Using env: {'DISPLAY': ':0', 04:25:16 INFO - 'HOME': '/home/cltbld', 04:25:16 INFO - 'LANG': 'en_US.UTF-8', 04:25:16 INFO - 'LANGUAGE': 'en_US:en', 04:25:16 INFO - 'LOGNAME': 'cltbld', 04:25:16 INFO - 'MAIL': '/var/mail/cltbld', 04:25:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:16 INFO - 'MOZ_NO_REMOTE': '1', 04:25:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:16 INFO - 'NO_EM_RESTART': '1', 04:25:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:16 INFO - 'PWD': '/builds/slave/test', 04:25:16 INFO - 'SHELL': '/bin/bash', 04:25:16 INFO - 'SHLVL': '1', 04:25:16 INFO - 'TERM': 'linux', 04:25:16 INFO - 'TMOUT': '86400', 04:25:16 INFO - 'USER': 'cltbld', 04:25:16 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468841072.408528-2080761596', 04:25:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:16 INFO - '_': '/tools/buildbot/bin/python'} 04:25:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:16 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)) 04:25:16 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)) 04:25:16 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)) 04:25:16 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)) 04:25:16 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)) 04:25:16 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)) 04:25:16 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)) 04:25:16 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)) 04:25:16 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)) 04:25:16 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)) 04:25:16 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)) 04:25:16 INFO - Cleaning up... 04:25:16 INFO - Return code: 0 04:25:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:25:16 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')]} 04:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:16 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')]} 04:25:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:16 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 0x7ffe4c333f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1210350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129f1c0>, '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 0x12a00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a0550>, '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': '62c568580acbfdaac3eec7be000001dc-1468841072.408528-2080761596', '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 04:25:16 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 04:25:16 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 04:25:16 INFO - Using env: {'DISPLAY': ':0', 04:25:16 INFO - 'HOME': '/home/cltbld', 04:25:16 INFO - 'LANG': 'en_US.UTF-8', 04:25:16 INFO - 'LANGUAGE': 'en_US:en', 04:25:16 INFO - 'LOGNAME': 'cltbld', 04:25:16 INFO - 'MAIL': '/var/mail/cltbld', 04:25:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:16 INFO - 'MOZ_NO_REMOTE': '1', 04:25:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:16 INFO - 'NO_EM_RESTART': '1', 04:25:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:16 INFO - 'PWD': '/builds/slave/test', 04:25:16 INFO - 'SHELL': '/bin/bash', 04:25:16 INFO - 'SHLVL': '1', 04:25:16 INFO - 'TERM': 'linux', 04:25:16 INFO - 'TMOUT': '86400', 04:25:16 INFO - 'USER': 'cltbld', 04:25:16 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468841072.408528-2080761596', 04:25:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:16 INFO - '_': '/tools/buildbot/bin/python'} 04:25:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:25:16 INFO - Cleaning up... 04:25:16 INFO - Return code: 0 04:25:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:25:16 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')]} 04:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:16 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')]} 04:25:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:16 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 0x7ffe4c333f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1210350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129f1c0>, '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 0x12a00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a0550>, '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': '62c568580acbfdaac3eec7be000001dc-1468841072.408528-2080761596', '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 04:25:16 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 04:25:16 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 04:25:16 INFO - Using env: {'DISPLAY': ':0', 04:25:16 INFO - 'HOME': '/home/cltbld', 04:25:16 INFO - 'LANG': 'en_US.UTF-8', 04:25:16 INFO - 'LANGUAGE': 'en_US:en', 04:25:16 INFO - 'LOGNAME': 'cltbld', 04:25:16 INFO - 'MAIL': '/var/mail/cltbld', 04:25:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:16 INFO - 'MOZ_NO_REMOTE': '1', 04:25:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:16 INFO - 'NO_EM_RESTART': '1', 04:25:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:16 INFO - 'PWD': '/builds/slave/test', 04:25:16 INFO - 'SHELL': '/bin/bash', 04:25:16 INFO - 'SHLVL': '1', 04:25:16 INFO - 'TERM': 'linux', 04:25:16 INFO - 'TMOUT': '86400', 04:25:16 INFO - 'USER': 'cltbld', 04:25:16 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468841072.408528-2080761596', 04:25:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:16 INFO - '_': '/tools/buildbot/bin/python'} 04:25:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:17 INFO - Downloading/unpacking flake8 04:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:25:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:25:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:25:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:25:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:25:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:25:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:25:19 INFO - no previously-included directories found matching 'docs/_build' 04:25:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:25:19 INFO - Running setup.py install for pep8 04:25:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:25:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:25:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:25:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:25:19 INFO - no previously-included directories found matching 'docs/_build' 04:25:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:25:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:25:19 INFO - Cleaning up... 04:25:19 INFO - Return code: 0 04:25:19 INFO - Running post-action listener: _resource_record_post_action 04:25:19 INFO - Running post-action listener: _start_resource_monitoring 04:25:19 INFO - Starting resource monitoring. 04:25:19 INFO - ##### 04:25:19 INFO - ##### Finished create-virtualenv step (success) 04:25:19 INFO - ##### 04:25:19 INFO - ##### 04:25:19 INFO - ##### Running install step. 04:25:19 INFO - ##### 04:25:19 INFO - Running pre-action listener: _resource_record_pre_action 04:25:19 INFO - Running main action method: install 04:25:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:25:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:25:20 INFO - Reading from file tmpfile_stdout 04:25:20 INFO - Detecting whether we're running mozinstall >=1.0... 04:25:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:25:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:25:20 INFO - Reading from file tmpfile_stdout 04:25:20 INFO - Output received: 04:25:20 INFO - Usage: mozinstall [options] installer 04:25:20 INFO - Options: 04:25:20 INFO - -h, --help show this help message and exit 04:25:20 INFO - -d DEST, --destination=DEST 04:25:20 INFO - Directory to install application into. [default: 04:25:20 INFO - "/builds/slave/test"] 04:25:20 INFO - --app=APP Application being installed. [default: firefox] 04:25:20 INFO - mkdir: /builds/slave/test/build/application 04:25:20 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'] 04:25:20 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 04:25:36 INFO - Reading from file tmpfile_stdout 04:25:36 INFO - Output received: 04:25:36 INFO - /builds/slave/test/build/application/firefox/firefox 04:25:36 INFO - Running post-action listener: _resource_record_post_action 04:25:36 INFO - ##### 04:25:36 INFO - ##### Finished install step (success) 04:25:36 INFO - ##### 04:25:36 INFO - ##### 04:25:36 INFO - ##### Running run-tests step. 04:25:36 INFO - ##### 04:25:36 INFO - Running pre-action listener: _resource_record_pre_action 04:25:36 INFO - Running main action method: run_tests 04:25:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:25:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:25:36 INFO - Python 2.7.3 04:25:36 INFO - Return code: 0 04:25:36 INFO - grabbing minidump binary from tooltool 04:25:36 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')]} 04:25:36 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 0x129f1c0>, '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 0x12a00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a0550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:25:36 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 04:25:36 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 04:25:36 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 04:25:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:25:36 INFO - Return code: 0 04:25:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:25:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:25:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:25:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:25:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:25:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:25:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:25:37 INFO - Return code: 0 04:25:37 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/W2CACFwkQ3ymcQtJCB-13Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 04:25:37 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/W2CACFwkQ3ymcQtJCB-13Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 04:25:37 INFO - Using env: {'DISPLAY': ':0', 04:25:37 INFO - 'HOME': '/home/cltbld', 04:25:37 INFO - 'LANG': 'en_US.UTF-8', 04:25:37 INFO - 'LANGUAGE': 'en_US:en', 04:25:37 INFO - 'LOGNAME': 'cltbld', 04:25:37 INFO - 'MAIL': '/var/mail/cltbld', 04:25:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:25:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:25:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:37 INFO - 'MOZ_NO_REMOTE': '1', 04:25:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:25:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:37 INFO - 'NO_EM_RESTART': '1', 04:25:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:37 INFO - 'PWD': '/builds/slave/test', 04:25:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:25:37 INFO - 'SHELL': '/bin/bash', 04:25:37 INFO - 'SHLVL': '1', 04:25:37 INFO - 'TERM': 'linux', 04:25:37 INFO - 'TMOUT': '86400', 04:25:37 INFO - 'USER': 'cltbld', 04:25:37 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1468841072.408528-2080761596', 04:25:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:37 INFO - '_': '/tools/buildbot/bin/python'} 04:25:37 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/W2CACFwkQ3ymcQtJCB-13Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 04:25:37 INFO - mozversion application_buildid: 20160718014952 04:25:37 INFO - mozversion application_changeset: c6dcf10108bdcb88f61533e589b4eb55255d38c1 04:25:37 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:25:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:25:37 INFO - mozversion application_name: Firefox 04:25:37 INFO - mozversion application_remotingname: firefox-dev 04:25:37 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:25:37 INFO - mozversion application_vendor: Mozilla 04:25:37 INFO - mozversion application_version: 49.0a2 04:25:37 INFO - mozversion platform_buildid: 20160718014952 04:25:37 INFO - mozversion platform_changeset: c6dcf10108bdcb88f61533e589b4eb55255d38c1 04:25:37 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:25:37 INFO - mozversion platform_version: 49.0a2 04:25:37 INFO - using testdate: 1468841137 04:25:37 INFO - actual date: 1468841137 04:25:37 INFO - starting webserver on 'localhost:36078' 04:25:37 INFO - SUITE-START | Running 2 tests 04:25:37 INFO - TEST-START | dromaeo_css 04:25:37 INFO - operating with platform_type : linux_ 04:25:37 INFO - Initialising browser for dromaeo_css test... 04:25:37 INFO - TEST-INFO | started process 3362 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpenOddv/profile http://localhost:36078/getInfo.html) 04:25:43 INFO - PROCESS | 3362 | __metrics Screen width/height:1600/1200 04:25:43 INFO - PROCESS | 3362 | colorDepth:24 04:25:43 INFO - PROCESS | 3362 | Browser inner width/height: 1024/697 04:25:43 INFO - PROCESS | 3362 | __metrics 04:25:44 ERROR - PROCESS | 3362 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 04:25:45 INFO - TEST-INFO | 3362: exit 0 04:25:45 INFO - Browser initialized. 04:25:45 INFO - Running cycle 1/1 for dromaeo_css test... 04:25:45 INFO - TEST-INFO | started process 3492 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpenOddv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:25:57 INFO - PROCESS | 3492 | RSS: Main: 156311552 04:25:57 INFO - PROCESS | 3492 | 04:26:46 INFO - PROCESS | 3492 | 1468841206605 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] 04:28:54 INFO - PROCESS | 3492 | Cycle 1(1): loaded http://localhost:36078/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36078/tests/dromaeo/cssquery-ext.html) 04:28:55 INFO - PROCESS | 3492 | RSS: Main: 159768576 04:28:55 INFO - PROCESS | 3492 | 04:31:57 INFO - PROCESS | 3492 | Cycle 1(1): loaded http://localhost:36078/tests/dromaeo/cssquery-ext.html (next: http://localhost:36078/tests/dromaeo/cssquery-jquery.html) 04:31:58 INFO - PROCESS | 3492 | RSS: Main: 157446144 04:31:58 INFO - PROCESS | 3492 | 04:34:59 INFO - PROCESS | 3492 | Cycle 1(1): loaded http://localhost:36078/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36078/tests/dromaeo/cssquery-mootools.html) 04:35:00 INFO - PROCESS | 3492 | RSS: Main: 157564928 04:35:00 INFO - PROCESS | 3492 | 04:38:02 INFO - PROCESS | 3492 | Cycle 1(1): loaded http://localhost:36078/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36078/tests/dromaeo/cssquery-prototype.html) 04:38:02 INFO - PROCESS | 3492 | RSS: Main: 157077504 04:38:02 INFO - PROCESS | 3492 | 04:41:05 INFO - PROCESS | 3492 | Cycle 1(1): loaded http://localhost:36078/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36078/tests/dromaeo/cssquery-yui.html) 04:41:05 INFO - PROCESS | 3492 | RSS: Main: 158658560 04:41:05 INFO - PROCESS | 3492 | 04:44:08 INFO - PROCESS | 3492 | Cycle 1(1): loaded http://localhost:36078/tests/dromaeo/cssquery-yui.html (next: http://localhost:36078/tests/dromaeo/cssquery-dojo.html) 04:44:08 INFO - PROCESS | 3492 | RSS: Main: 159322112 04:44:08 INFO - PROCESS | 3492 | 04:44:08 INFO - PROCESS | 3492 | __start_tp_report 04:44:08 INFO - PROCESS | 3492 | _x_x_mozilla_page_load 04:44:08 INFO - PROCESS | 3492 | _x_x_mozilla_page_load_details 04:44:08 INFO - PROCESS | 3492 | |i|pagename|runs| 04:44:08 INFO - PROCESS | 3492 | |0;dojo.html;3398.830058497075;3409.1306716787217;3433.75963682542;3440.7591468597207;3443.948340774887;5611.551075913922;5647.632903861246;5717.085266357383;5728.140778883169;5760.222369980052;5682.403347648499;5709.514691251238;5711.571632127597;5760.2511673482495;5774.682392468423;5085.1863701807715;5141.126008578532;5188.4811518848;5191.325127733389;5263.657862238962;5125.564327032207;5129.051125541787;5168.095583272912;5198.9480105198845;5265.447128051538;5110.897782044357;5121.1038068338075;5133.614978876581;5200.713960732158;5301.920471192916;5212.139996900507;5221.425643179247;5221.79112835488;5222.216667499867;5262.342207224097;4988.326575912278;5001.324821149135;5135.12702840518;5155.896882062375;5203.817866374697;5446.972765136149;5525.834224973257;5535.640183388107;5549.1676248562635;5581.274434323512;6027.065804800219;6065.757369705207;6076.726547305382;6084.726187321581;6087.269527656709;6034.577579569432;6091.847703807396;6116.235470566179;6129.295131059941;6131.049687298476;5516.117421212587;5558.055130627763;5561.332640083176;5561.888762224733;5568.972155139199;6100.48145907594;6127.601705889103;6145.477634401126;6156.476699480505;6168.784092556829;5846.1230815377185;5909.084091965752;5918.852028699231;5943.465088142088;5993.640381577119;5975.073863551156;6032.065029920369;6050.6974651267265;6064.241969753781;6081.8479538011015;5893.970530147321;6050.183225264621;6059.575829691968;6060.606060606046;6065.878682426327;5993.700314984233;6067.150598916155;6119.571629985859;6168.1056246844855;6176.907346389808;4473;4486.798094085774;4492.820287188476;4494.640428765691;4515.074409745994;3927.3912543555793;3963.207358528306;4048.291548978917;4066.7153299268766;4072.6334629883454;5652.434756524314;5656.434356564393;5744.195812586241;5828.0966450200285;5837.737301821428;6008.819735407945;6057.7879774207695;6066.545009124245;6078.513718902477;6080.331163572004;5724.112762521816;5730.226419433407;5784.94215057844;5786.71066446676;5787.623804452697;4958;4991.326170966946;4994.425641051325;5018.899622007612;5034.421041580265;6303.810885673437;6355.618662880242;6356.745730170742;6360.459360954371;6360.745570177233;6011.939880601138;6069.514438844882;6071.453569178795;6083.7870674526175;6122.724477398617;6444.065610486547;6490.058941453369;6491.7403303869205;6492.253390860112;6507.121538592419;6055.061465472859;6064.3935606439;6064.969675151596;6069.817905462844;6080.148779171008;6027.668478233739;6041.456268935817;6072.939270607238;6091.147239386578;6150.354212807591;5924.881502369843;5960.880782384242;5973.522118230618;5976.581639285208;5993.910091348721;5915.112733090071;5939.465448109518;5956.821295361146;5964.731587078679;5991.281046274475;5637.661740295595;5781.248437703071;5812.593118481665;5826.912596311144;5894.970525147347;5964.433378829178;5989.8203053908455;5994.820155395345;6024.277086749618;6026.939730602813;5772.826815195551;5888.528917686489;5897.321807992136;5902.439268269508;5906.822795316148 04:44:08 INFO - PROCESS | 3492 | |1;ext.html;592.8280798568416;649.6167261315823;652.2433976587159;655.1286788571201;665.3579295979379;34920;38175;47389.289160662614;48374.27438588415;48549.271760923526;48396;48576.75711621446;48870.51129488704;48941.265881011816;49156.262656060186;9133.223675987549;9282.071792820732;9294.070592940685;9296;9307.72076837696;9147.58835852385;9239.122283383102;9242.12199841014;9243.445393276392;9263.07369263075;9295.48874811885;9338.953305233465;9341.346105772598;9343.76640583984;9346.392484488486;9231.815363692689;9233.95383023084;9291.907080929206;9301.069893010712;9321.906780932206;9009.864852027225;9081.45511269326;9140.542972851397;9177;9181.954090229572;45784;46050;46093.53906460926;46276.305855412196;46451;3708.35103856824;3719.200371920023;3914.3932690432744;3962.286788378091;4075.735077219971;31780.523292150636;35847;35979.82010089959;36085.63914360875;36176.63823361785;4664.137134630104;4797.808087676523;4844.709317440965;4864.270359446076;4922.015596880638;394613;401251;401758.991205045;403112;403492;38693.22613547713;68937.31062689409;69524;69748.6512567444;69921.30078699147;39423.40864887029;41624.583754162675;41721.79139104285;41726.37410438846;41760.37359439611;17524.561885952953;17671.38150164738;17808.643827123644;17829.643407131785;17851;13713.314334283246;13909.165450073027;13975.79036314456;13990.930045349709;14002.369893354824;9252.074792520829;9306.767330816783;9320.394174378644;9354.438733676001;9390.62437502506;3622.8913132606062;3647.835847386874;3650.762700424464;3690.612485689018;3703.2593481303848;1061.930974486656;1117.2793548161553;1175.3241885915634;1180.3331117918349;1200.477792160413;33301;34029.14927126842;34171.31657366839;34235.486467703005;34667.65332346695;1206.9939650301692;1259.6724851538484;1289.8194252804615;1298.5260379961435;1353.1610401551102;17159.656806863793;17668.02825844591;18010.28902254284;18068.63862722738;18119.275228990693;628717;631607;652234;684869;1090896;60788;60958.99999999911;61383.69308153431;61392.38607613956;61731.691341543;1454.6508837879044;1483.5104415542844;1492.156931333793;1495.8055452791068;1496.5510346895887;32709.345813083128;32737.67262327346;33127;33145.50281745824;33879.830600847825;52200.738996304775;52735.47264527459;52837.471625284794;52856;53022;393053;393205;393508;393811;393850;28878.711212888444;29552.55671164891;29758.25604359908;29825.850870745508;29922;52635;52635.73682131565;53195.202071968175;53990.73004634952;54585.727071365975;43646.781766090964;44881.55118448904;44942.3258651127;45309.546904530536;46190.76904615456;43608.56391436045;44155.11689766251;44245.00897459558;44255.557444426435;44363.55636443723;44092.55907441013;44883.77558112189;45091.54908450873;45174.54825451703;45287.77356113198;38484.80757596194;38728.64449744245;39385.60614393934;39874.00314992148;39955;29902.401951960404;30717.539236911016;30775;30785.538216927212;30950.380992380477 04:44:08 INFO - PROCESS | 3492 | |2;jquery.html;429.4095618524529;433.6985794872564;437.1671964906852;438.6359321762937;444.27583039645396;18606.34877779278;19427.805721942776;20393.694094588576;20400.489987750312;20414.795852041476;18609.627807443878;18717;18792.71810922837;19623.90188049061;19780.10989505472;5226.712530810813;5393.460653934595;5402.135658294674;5438.91841622376;5443.292371991635;5279.1817268323475;5335.386430560497;5386.3536375634785;5423.7830486780485;5900.291964964189;5798.159266906296;5810.709464526778;5815.127730840365;5878.794242201524;5889.911651325234;5313.256144139785;5346.625736198468;5510.952918945388;5823.213866128082;5834.212381328509;5196.610254230948;5198.2722418861385;5212.739363031833;5215.165573508259;5247;11304.265222760494;14821.036632618845;21894.671579926315;23209.651855222186;23237.3028809136;2188.2341180586827;2209.723784526934;2268.663276824873;2310.3415526575013;2529;10294.845577316346;10364.896351036468;10472.319299245524;10560.47197640115;10700.732481687943;1941.5049162463622;2040.3878836349184;2093.7906209379094;2110.8944552772455;2132.8613640113344;84147.57926210391;88225;88811;88935;91088.08911910863;11861.288322700493;11870.703232419259;11903.166778325607;11936.880631193751;12084.939575302244;16801;16855.57861053459;16874.15629218534;16929.576760580836;16949.745753813702;8813.338999575057;8911.777205569782;8920.776980575538;9004.8649270261;9040;8702.521361325062;8773.166549177946;8788.648454061893;8818.426802257833;8867.822643547093;5009.524095210949;5027.271045698353;5049.469805670352;5096.872578185501;5130.127878260705;2055.403932859484;2055.8869262190724;2079.480129967508;2105.557832855087;2118.5445129297277;1062.0600768319937;1062.8086944349936;1108.490094556513;1135.500379832871;1184.3545267828881;17845.910770446324;20915.581688366146;21179.47051323729;21215;21591.46021349479;1028.9742756430999;1112.3270421395102;1155.439611788282;1190.345310079453;1193.7612477504533;11250.831237531444;11634.592789252336;11654.650360489199;11677;11698.2981021139;499720;513747;517246;523588;524622;61154.38845611576;63495.6825215871;76263.61868190735;90626.54686726524;94848;1108.8336749487642;1137.0960086731068;1151.3552410649895;1160.2458402038742;1175.0364700945142;18294.268229271212;18687.43937681872;18745.90627046856;18838.52903677419;18852.905735471235;41423.34306627822;42775.57224427716;43015.354769677855;43651.90870228269;44389.77805110954;58886;60436.395636043075;60450.395496044475;62211.37788622237;62992;6251.78118765841;7831.686732530635;8261.752147435587;8306.584670766559;8358.707445239388;9741.172000380047;13440.260785656883;13732.382042808298;13750.793738094137;13898.930505347813;12337.753244935231;12355.3822308886;12400.56598019065;12594.811077834023;12634.620961371174;11673.241239319417;11870.881291187323;11985.34080625574;11993;12043.698907527381;12283.324417156784;12563;12656.6835829105;12775.425105870072;12876.549320773727;8295.543745094077;8420.36847236472;8430.578471076544;8459.323254139532;8484.109168537214;11280.943595282299;12701.36493175356;12715.491380344683;12801.487940482277;12860.164089334163 04:44:08 INFO - PROCESS | 3492 | |3;mootools.html;1438.798568200452;1493.9178345191015;1661.2939500712203;1831.5146486181172;1838.8436982856465;8452.619632116553;9042.547872606376;9339.859902101465;9895.455749933752;9906.801863962717;8955.820883582324;9315.627374905012;9347.813043739121;9367.391119577223;9380.57787399567;2373.7744914233162;2441.890114944823;2453.5460939726117;2456.091246238894;2457.373369790701;2408.0488207158164;2436.2447641231274;2503.7496250374907;2505.1482495951373;2506.9122580709677;2451.705795304566;2452.264320703791;2480.6775119234476;2491.950160996779;2497.962530562043;2400.519896020794;2420.6369044643357;2435.3546310227803;2446.3150317911013;2461.6307553867064;2368.7749663781915;2393.102586530051;2426.46617744096;2427.4052857050137;2435.585950388438;9118;9198.218151457135;9233.861492077624;9242.6302947882;9264.6294148234;5548.86127846803;5673.461021202979;5710.914336284959;5715.6284841485585;5717;3613.5483064616924;3682.3371793077235;3754.5682246541724;3795.760501304244;3837.194189220267;1267.1446773427992;1278.1755767529985;1303.120393734235;1315.0400207848324;1317.3084130831294;13601.727965440636;13647.317634118353;13669.248191349472;13723.039387242898;13856.307184640727;5079.923801142986;5150.948490515122;5201.3238279024245;5217.06092903281;5224.216367544898;11291.943540282246;11361.829572556418;11373.715657108638;11426.600068997544;11608.24546404481;5643.971780141073;5664.122061080539;5737.3688894221605;5752.654840709571;5834.591578589543;4710.929336059962;5078.695278283315;5191.974040129775;5199.63602547818;5298.761555730001;4463.732176069381;4566.611837993742;4588.7246765194195;4596.540345965377;4602.05657840142;1380.882624976888;1395.3581352577726;1403.2702994442832;1409.1545072956144;1415.1579810013027;1067.2955849139687;1070.550368845087;1084.4848696869083;1095.6055819904827;1104.6575561575937;6727.327267273331;6816.693248803816;6910.792676219721;6914.51598388108;6946.79159625212;454.9772511374418;464.0255463526567;469.9036697477009;472.4425178289651;491.4544855210713;4458.041521072985;4697.10754956564;4717.528247175255;4732.976335118303;4739.881502962454;11307.49116289769;11321.603743868925;11785.528578856922;11889.464974076187;11949.044076473861;11992;12004.099692523096;12042.39788010596;12068.275903445821;12172.330521821385;8920.8661870072;9103.590338434786;9111.17999380059;9137.086291370942;9152.588133534007;6661.500387471056;6863.10779598649;6867.278935711678;6884.208316043719;6951.304869513008;10970.067544258827;11014.559417623526;11055.72360690989;11061.557537698402;11255.774884502427;10915.83626245591;11155.83266251023;11196.888031119584;11208.719782005515;11250.606228781953;8041.316488098577;8237.917620823955;8279.172082791914;8503.489790612583;8530;9378.249740020645;9620.615175392906;9630.759231019001;9736.41581505112;9745.12293893553;8284.83430331402;8358.498490090615;8413.831723365622;8512.53181075022;8783.472991620523;8094.797630059295;8162.306203972729;8490.150984901707;8529.616167272612;8658.78353041179;7811.882821757565;7903.68385264583;8018.879716804136;8021.037475502977;8026.237507436784;5690.516306113861;5952.779680165642;5961.672108033927;6007.54943379257;6119.265688117454;5938.138969849434;5994.220751302303;6004.5796794225735;6066.211392518944;6152.261728592597 04:44:08 INFO - PROCESS | 3492 | |4;prototype.html;346.4041848021402;349.5839950458954;356.37634140254545;363.6363636363638;363.63999640356053;5631.944340315786;5677.233573467581;5799.652020878751;5822.4177582241755;5885.087346612352;5709.314882214129;5724.942750572493;5725.368270043038;5741.971290143554;5743.138529220619;4440.888977775549;4455.621272191867;4468.932966005513;4469.837842161029;4477.328400739882;4381.211381951263;4432.160653328865;4433.866983990485;4441.75570343631;4502.279635258359;4393.165298593257;4400.97799511002;4403.955960440403;4426.557344265564;4442.155990361837;4447.310666846644;4459.859267551561;4464.352668862996;4465.665075119379;4466.932996005063;3671.3575124353133;3868.207017561393;3987.7469229885314;3988.222296652154;3999.8200080996426;5448.509634132947;5454.563634909237;5465.480779325958;5533.142362933751;5547.5007249347345;5017.49825017499;5052.545270925634;5054.418741844698;5069.569086627641;5095.643304968654;5697.974364614368;5997.850053748692;5997.970010149921;6005.978983572803;6008.549358798107;4276.2516559601945;4285.400043993844;4288.421063156465;4293.334533147367;4299.269124248885;6236.438720515175;6247.4377306042215;6259.311475737711;6288.52836037299;6289.433950944483;4257.8509752158525;4331.350297455407;4336.6313863321975;4342.913141737147;4349.217140914666;4434.379186913835;4441.866743997685;4458.331250312479;4462.9107417851465;4474.910501789946;5037.471065538139;5042.067217564762;5049.2426136079885;5098.719570423588;5115.71863547501;5794.913076303858;5846.6784326862435;5999.59009632736;6018.458338749446;6051.727672254759;1489.5829167833024;1517.3778750712156;1524.885633577486;1524.9771253431206;1525.8474152584652;963.937344072633;981.1954197557934;988.5057471264367;989.0702739424918;994.005994005994;5248.819015721432;5270.446603106619;5295.814646487354;5345.86635334112;5359.973200133974;5444.401115877329;5478.931798193024;5497.587680923947;5502.2296878437055;5523.585731070186;4978.6017118630425;5220.973895130576;5234.633575649668;5267.841964741064;5298.258243845865;2977.955330670042;2994.3562134141266;2997.2207226121363;3005.218643152796;3019.275373910246;5759.5521903190975;5763.625364351387;5763.933672270643;5837.970810146007;5859.44335288147;5962.2249107615735;6377.649229292433;6417.197850268716;6428.260750013715;6429.549931504844;6548.738050478023;6590.275069742324;6592.472602191813;6595.340465953366;6617.371349721865;6038;6178.505719542336;6304.3380445054445;6308.71610777507;6333.778317759041;6151.585135418968;6155.630662160284;6215.689215539295;6228.719707613078;6228.937710623017;6385.425311721968;6505.772297969548;6516.761815255087;6541.476681865534;6634.175601709569;4387.495438024668;4393.714408563433;4410.448693913261;4436.467623885154;4455.331700244989;6045.576809623284;6110.236220472441;6268.905966410416;6300.810975670737;6311.400416960381;6019.217501724747;6057.57596968208;6077.389491784592;6079.665618391031;6091.7563297467605;6039.879202416015;6075.787347442818;6077.908831367621;6103.917521651538;6105.267367915879;5661.66030038199;5981.192539007352;5985.551083668829;6001.019663510943;6027.517798576016;6133.417325354084;6161.322254552086;6163.506919446523;6164.815055548341;6181.84545386369;5496.31296087989;5924.52603791687;5948.583599148191;5952.76771210796;6028.186194863637 04:44:08 INFO - PROCESS | 3492 | |5;yui.html;785.1951749456806;786.7757689058619;809.8947136872206;850.9404341696082;915.7802127489405;15929.442469513584;16026.198690065508;16074.758878616802;16380.672386552262;17263.56841078972;16038.919805400987;16105.83894161058;16142;16147;16201.594960126004;848.0713618587637;877.1491653096487;877.5787621941472;881.6693739847557;881.9294456443469;846.022843615625;855.589317127779;856.8543347630917;857.1128881607538;858.3262139220682;892.4154678685471;892.8526793079134;896.3770179725094;897.161154320709;897.6499165325529;884.8141890203001;885.707716453572;886.521278509604;888.9333300002526;891.2869704236617;653.9901901471482;654.8559316950264;657.011198146786;658.3778329478645;658.8945768676989;16806.663866722596;16882;16961.915190424093;16997.57506062346;17002;15038.699226015418;15080.622984425367;15547.689046219126;15655.765163522556;15766.684666306724;12682.55611053618;12929.133701150278;12960.80558791619;13145.802812957812;13220.537281195113;4062.939055914164;4209.5790420957965;4263.339182426729;4284.67864910133;4285.764282964436;78225.60887195585;80981;81142.18857811406;81783;82057.58971205166;12124.454399552042;12151.513939442324;12253;12285.815712764315;12459.563915262923;22884.4278893029;22911.88544057269;22963;23028.194013209457;23230.65154022691;8949.060348663297;9026.323025772961;9181.862272065924;9405.388649737744;9526.333156678966;4939.530744579331;5114.872128196825;5131.435542090367;5168.8449346519665;5197.7141257231215;3800.7529510582276;3925.0579860833764;3956.40653901917;3967;3969;638.5913015669975;644.291279592454;647.5078940005629;648.0732552450041;652.7519542573887;660.6828722213269;700.6426722371627;715.5098757351232;726.8473620539746;746.4289818289013;11170.553177872956;11343.659690209306;11389.338841747143;11506.827397589042;11641.243319184226;627.6234259444296;636.8726254749068;676.8477092654211;751.5490705576719;768.7347864986571;4979.402471703346;5077.390713114376;5101.20931255656;5121.718305493159;5143.305653736773;73076.269237308;74464.62767686235;98304.50847745716;100185.49907250417;101353;98217.50891245641;98277;102132.48933755283;102864;103740.48129759454;93551;93651.53174234086;96360;97550.51224743831;98119;10569.365838049742;10711.303765255234;10711.8928810714;10822.621208257673;10986.670399888017;47452.52547474481;49073.5092649069;51432.22851657153;52062;55247;73809.6309518449;81917;82326;84554.57722711594;86008;14270.429182832571;14422;14553.636159096108;14618.926905365404;14642.633934151732;16097.114658693885;16110.67778644444;16116.27476763525;16151.434699785452;16557.83442165563;14986.700265994838;15600.453984110502;15755.606109846887;15777.368905243662;15821.208939553206;14480.927595361956;14880;15149.318280677617;15399.846001540289;15435.768463473281;14995.775063374276;15197.31612077437;15659.217039148225;16077.437289694804;16109.516714498584;11493.252938558968;11517.769644607228;11595.188336816342;11689.298642081503;11903.226290291102;12200.267983920992;12410;12435;12609.621711348675;12636.55772047974 04:44:08 INFO - PROCESS | 3492 | __end_tp_report 04:44:08 INFO - PROCESS | 3492 | __start_cc_report 04:44:08 INFO - PROCESS | 3492 | _x_x_mozilla_cycle_collect,344 04:44:08 INFO - PROCESS | 3492 | __end_cc_report 04:44:08 INFO - PROCESS | 3492 | __startTimestamp1468842248774__endTimestamp 04:44:08 INFO - PROCESS | 3492 | 04:44:08 INFO - PROCESS | 3492 | ------- Summary: start ------- 04:44:08 INFO - PROCESS | 3492 | Number of tests: 6 04:44:08 INFO - PROCESS | 3492 | 04:44:08 INFO - PROCESS | 3492 | [#0] dojo.html Cycles:165 Average:5632.84 Median:5893.97 stddev:656.10 (11.1%) stddev-sans-first:634.27 04:44:08 INFO - PROCESS | 3492 | Values: 3398.8 3409.1 3433.8 3440.8 3443.9 5611.6 5647.6 5717.1 5728.1 5760.2 5682.4 5709.5 5711.6 5760.3 5774.7 5085.2 5141.1 5188.5 5191.3 5263.7 5125.6 5129.1 5168.1 5198.9 5265.4 5110.9 5121.1 5133.6 5200.7 5301.9 5212.1 5221.4 5221.8 5222.2 5262.3 4988.3 5001.3 5135.1 5155.9 5203.8 5447.0 5525.8 5535.6 5549.2 5581.3 6027.1 6065.8 6076.7 6084.7 6087.3 6034.6 6091.8 6116.2 6129.3 6131.0 5516.1 5558.1 5561.3 5561.9 5569.0 6100.5 6127.6 6145.5 6156.5 6168.8 5846.1 5909.1 5918.9 5943.5 5993.6 5975.1 6032.1 6050.7 6064.2 6081.8 5894.0 6050.2 6059.6 6060.6 6065.9 5993.7 6067.2 6119.6 6168.1 6176.9 4473.0 4486.8 4492.8 4494.6 4515.1 3927.4 3963.2 4048.3 4066.7 4072.6 5652.4 5656.4 5744.2 5828.1 5837.7 6008.8 6057.8 6066.5 6078.5 6080.3 5724.1 5730.2 5784.9 5786.7 5787.6 4958.0 4991.3 4994.4 5018.9 5034.4 6303.8 6355.6 6356.7 6360.5 6360.7 6011.9 6069.5 6071.5 6083.8 6122.7 6444.1 6490.1 6491.7 6492.3 6507.1 6055.1 6064.4 6065.0 6069.8 6080.1 6027.7 6041.5 6072.9 6091.1 6150.4 5924.9 5960.9 5973.5 5976.6 5993.9 5915.1 5939.5 5956.8 5964.7 5991.3 5637.7 5781.2 5812.6 5826.9 5895.0 5964.4 5989.8 5994.8 6024.3 6026.9 5772.8 5888.5 5897.3 5902.4 5906.8 04:44:08 INFO - PROCESS | 3492 | 04:44:08 INFO - PROCESS | 3492 | [#1] ext.html Cycles:180 Average:66672.73 Median:43869.67 stddev:146386.97 (333.7%) stddev-sans-first:146713.55 04:44:08 INFO - PROCESS | 3492 | Values: 592.8 649.6 652.2 655.1 665.4 34920.0 38175.0 47389.3 48374.3 48549.3 48396.0 48576.8 48870.5 48941.3 49156.3 9133.2 9282.1 9294.1 9296.0 9307.7 9147.6 9239.1 9242.1 9243.4 9263.1 9295.5 9339.0 9341.3 9343.8 9346.4 9231.8 9234.0 9291.9 9301.1 9321.9 9009.9 9081.5 9140.5 9177.0 9182.0 45784.0 46050.0 46093.5 46276.3 46451.0 3708.4 3719.2 3914.4 3962.3 4075.7 31780.5 35847.0 35979.8 36085.6 36176.6 4664.1 4797.8 4844.7 4864.3 4922.0 394613.0 401251.0 401759.0 403112.0 403492.0 38693.2 68937.3 69524.0 69748.7 69921.3 39423.4 41624.6 41721.8 41726.4 41760.4 17524.6 17671.4 17808.6 17829.6 17851.0 13713.3 13909.2 13975.8 13990.9 14002.4 9252.1 9306.8 9320.4 9354.4 9390.6 3622.9 3647.8 3650.8 3690.6 3703.3 1061.9 1117.3 1175.3 1180.3 1200.5 33301.0 34029.1 34171.3 34235.5 34667.7 1207.0 1259.7 1289.8 1298.5 1353.2 17159.7 17668.0 18010.3 18068.6 18119.3 628717.0 631607.0 652234.0 684869.0 1090896.0 60788.0 60959.0 61383.7 61392.4 61731.7 1454.7 1483.5 1492.2 1495.8 1496.6 32709.3 32737.7 33127.0 33145.5 33879.8 52200.7 52735.5 52837.5 52856.0 53022.0 393053.0 393205.0 393508.0 393811.0 393850.0 28878.7 29552.6 29758.3 29825.9 29922.0 52635.0 52635.7 53195.2 53990.7 54585.7 43646.8 44881.6 44942.3 45309.5 46190.8 43608.6 44155.1 44245.0 44255.6 44363.6 44092.6 44883.8 45091.5 45174.5 45287.8 38484.8 38728.6 39385.6 39874.0 39955.0 29902.4 30717.5 30775.0 30785.5 30950.4 04:44:08 INFO - PROCESS | 3492 | 04:44:08 INFO - PROCESS | 3492 | [#2] jquery.html Cycles:180 Average:29790.32 Median:11889.85 stddev:84817.52 (713.4%) stddev-sans-first:85026.80 04:44:08 INFO - PROCESS | 3492 | Values: 429.4 433.7 437.2 438.6 444.3 18606.3 19427.8 20393.7 20400.5 20414.8 18609.6 18717.0 18792.7 19623.9 19780.1 5226.7 5393.5 5402.1 5438.9 5443.3 5279.2 5335.4 5386.4 5423.8 5900.3 5798.2 5810.7 5815.1 5878.8 5889.9 5313.3 5346.6 5511.0 5823.2 5834.2 5196.6 5198.3 5212.7 5215.2 5247.0 11304.3 14821.0 21894.7 23209.7 23237.3 2188.2 2209.7 2268.7 2310.3 2529.0 10294.8 10364.9 10472.3 10560.5 10700.7 1941.5 2040.4 2093.8 2110.9 2132.9 84147.6 88225.0 88811.0 88935.0 91088.1 11861.3 11870.7 11903.2 11936.9 12084.9 16801.0 16855.6 16874.2 16929.6 16949.7 8813.3 8911.8 8920.8 9004.9 9040.0 8702.5 8773.2 8788.6 8818.4 8867.8 5009.5 5027.3 5049.5 5096.9 5130.1 2055.4 2055.9 2079.5 2105.6 2118.5 1062.1 1062.8 1108.5 1135.5 1184.4 17845.9 20915.6 21179.5 21215.0 21591.5 1029.0 1112.3 1155.4 1190.3 1193.8 11250.8 11634.6 11654.7 11677.0 11698.3 499720.0 513747.0 517246.0 523588.0 524622.0 61154.4 63495.7 76263.6 90626.5 94848.0 1108.8 1137.1 1151.4 1160.2 1175.0 18294.3 18687.4 18745.9 18838.5 18852.9 41423.3 42775.6 43015.4 43651.9 44389.8 58886.0 60436.4 60450.4 62211.4 62992.0 6251.8 7831.7 8261.8 8306.6 8358.7 9741.2 13440.3 13732.4 13750.8 13898.9 12337.8 12355.4 12400.6 12594.8 12634.6 11673.2 11870.9 11985.3 11993.0 12043.7 12283.3 12563.0 12656.7 12775.4 12876.5 8295.5 8420.4 8430.6 8459.3 8484.1 11280.9 12701.4 12715.5 12801.5 12860.2 04:44:08 INFO - PROCESS | 3492 | 04:44:08 INFO - PROCESS | 3492 | [#3] mootools.html Cycles:180 Average:6365.14 Median:4714.23 stddev:3635.88 (77.1%) stddev-sans-first:3627.23 04:44:08 INFO - PROCESS | 3492 | Values: 1438.8 1493.9 1661.3 1831.5 1838.8 8452.6 9042.5 9339.9 9895.5 9906.8 8955.8 9315.6 9347.8 9367.4 9380.6 2373.8 2441.9 2453.5 2456.1 2457.4 2408.0 2436.2 2503.7 2505.1 2506.9 2451.7 2452.3 2480.7 2492.0 2498.0 2400.5 2420.6 2435.4 2446.3 2461.6 2368.8 2393.1 2426.5 2427.4 2435.6 9118.0 9198.2 9233.9 9242.6 9264.6 5548.9 5673.5 5710.9 5715.6 5717.0 3613.5 3682.3 3754.6 3795.8 3837.2 1267.1 1278.2 1303.1 1315.0 1317.3 13601.7 13647.3 13669.2 13723.0 13856.3 5079.9 5150.9 5201.3 5217.1 5224.2 11291.9 11361.8 11373.7 11426.6 11608.2 5644.0 5664.1 5737.4 5752.7 5834.6 4710.9 5078.7 5192.0 5199.6 5298.8 4463.7 4566.6 4588.7 4596.5 4602.1 1380.9 1395.4 1403.3 1409.2 1415.2 1067.3 1070.6 1084.5 1095.6 1104.7 6727.3 6816.7 6910.8 6914.5 6946.8 455.0 464.0 469.9 472.4 491.5 4458.0 4697.1 4717.5 4733.0 4739.9 11307.5 11321.6 11785.5 11889.5 11949.0 11992.0 12004.1 12042.4 12068.3 12172.3 8920.9 9103.6 9111.2 9137.1 9152.6 6661.5 6863.1 6867.3 6884.2 6951.3 10970.1 11014.6 11055.7 11061.6 11255.8 10915.8 11155.8 11196.9 11208.7 11250.6 8041.3 8237.9 8279.2 8503.5 8530.0 9378.2 9620.6 9630.8 9736.4 9745.1 8284.8 8358.5 8413.8 8512.5 8783.5 8094.8 8162.3 8490.2 8529.6 8658.8 7811.9 7903.7 8018.9 8021.0 8026.2 5690.5 5952.8 5961.7 6007.5 6119.3 5938.1 5994.2 6004.6 6066.2 6152.3 04:44:08 INFO - PROCESS | 3492 | 04:44:08 INFO - PROCESS | 3492 | [#4] prototype.html Cycles:180 Average:5006.56 Median:5589.72 stddev:1495.61 (26.8%) stddev-sans-first:1458.33 04:44:08 INFO - PROCESS | 3492 | Values: 346.4 349.6 356.4 363.6 363.6 5631.9 5677.2 5799.7 5822.4 5885.1 5709.3 5724.9 5725.4 5742.0 5743.1 4440.9 4455.6 4468.9 4469.8 4477.3 4381.2 4432.2 4433.9 4441.8 4502.3 4393.2 4401.0 4404.0 4426.6 4442.2 4447.3 4459.9 4464.4 4465.7 4466.9 3671.4 3868.2 3987.7 3988.2 3999.8 5448.5 5454.6 5465.5 5533.1 5547.5 5017.5 5052.5 5054.4 5069.6 5095.6 5698.0 5997.9 5998.0 6006.0 6008.5 4276.3 4285.4 4288.4 4293.3 4299.3 6236.4 6247.4 6259.3 6288.5 6289.4 4257.9 4331.4 4336.6 4342.9 4349.2 4434.4 4441.9 4458.3 4462.9 4474.9 5037.5 5042.1 5049.2 5098.7 5115.7 5794.9 5846.7 5999.6 6018.5 6051.7 1489.6 1517.4 1524.9 1525.0 1525.8 963.9 981.2 988.5 989.1 994.0 5248.8 5270.4 5295.8 5345.9 5360.0 5444.4 5478.9 5497.6 5502.2 5523.6 4978.6 5221.0 5234.6 5267.8 5298.3 2978.0 2994.4 2997.2 3005.2 3019.3 5759.6 5763.6 5763.9 5838.0 5859.4 5962.2 6377.6 6417.2 6428.3 6429.5 6548.7 6590.3 6592.5 6595.3 6617.4 6038.0 6178.5 6304.3 6308.7 6333.8 6151.6 6155.6 6215.7 6228.7 6228.9 6385.4 6505.8 6516.8 6541.5 6634.2 4387.5 4393.7 4410.4 4436.5 4455.3 6045.6 6110.2 6268.9 6300.8 6311.4 6019.2 6057.6 6077.4 6079.7 6091.8 6039.9 6075.8 6077.9 6103.9 6105.3 5661.7 5981.2 5985.6 6001.0 6027.5 6133.4 6161.3 6163.5 6164.8 6181.8 5496.3 5924.5 5948.6 5952.8 6028.2 04:44:08 INFO - PROCESS | 3492 | 04:44:08 INFO - PROCESS | 3492 | [#5] yui.html Cycles:180 Average:21413.49 Median:4136.26 stddev:29291.69 (708.2%) stddev-sans-first:29332.91 04:44:08 INFO - PROCESS | 3492 | Values: 785.2 786.8 809.9 850.9 915.8 15929.4 16026.2 16074.8 16380.7 17263.6 16038.9 16105.8 16142.0 16147.0 16201.6 848.1 877.1 877.6 881.7 881.9 846.0 855.6 856.9 857.1 858.3 892.4 892.9 896.4 897.2 897.6 884.8 885.7 886.5 888.9 891.3 654.0 654.9 657.0 658.4 658.9 16806.7 16882.0 16961.9 16997.6 17002.0 15038.7 15080.6 15547.7 15655.8 15766.7 12682.6 12929.1 12960.8 13145.8 13220.5 4062.9 4209.6 4263.3 4284.7 4285.8 78225.6 80981.0 81142.2 81783.0 82057.6 12124.5 12151.5 12253.0 12285.8 12459.6 22884.4 22911.9 22963.0 23028.2 23230.7 8949.1 9026.3 9181.9 9405.4 9526.3 4939.5 5114.9 5131.4 5168.8 5197.7 3800.8 3925.1 3956.4 3967.0 3969.0 638.6 644.3 647.5 648.1 652.8 660.7 700.6 715.5 726.8 746.4 11170.6 11343.7 11389.3 11506.8 11641.2 627.6 636.9 676.8 751.5 768.7 4979.4 5077.4 5101.2 5121.7 5143.3 73076.3 74464.6 98304.5 100185.5 101353.0 98217.5 98277.0 102132.5 102864.0 103740.5 93551.0 93651.5 96360.0 97550.5 98119.0 10569.4 10711.3 10711.9 10822.6 10986.7 47452.5 49073.5 51432.2 52062.0 55247.0 73809.6 81917.0 82326.0 84554.6 86008.0 14270.4 14422.0 14553.6 14618.9 14642.6 16097.1 16110.7 16116.3 16151.4 16557.8 14986.7 15600.5 15755.6 15777.4 15821.2 14480.9 14880.0 15149.3 15399.8 15435.8 14995.8 15197.3 15659.2 16077.4 16109.5 11493.3 11517.8 11595.2 11689.3 11903.2 12200.3 12410.0 12435.0 12609.6 12636.6 04:44:08 INFO - PROCESS | 3492 | -------- Summary: end -------- 04:44:08 INFO - PROCESS | 3492 | 04:44:09 INFO - TEST-INFO | 3492: exit 0 04:44:09 INFO - TEST-OK | dromaeo_css | took 1112118ms 04:44:09 INFO - TEST-START | kraken 04:44:09 INFO - operating with platform_type : linux_ 04:44:09 INFO - Initialising browser for kraken test... 04:44:09 INFO - TEST-INFO | started process 3774 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvH0xpr/profile http://localhost:36078/getInfo.html) 04:44:13 INFO - PROCESS | 3774 | __metrics Screen width/height:1600/1200 04:44:13 INFO - PROCESS | 3774 | colorDepth:24 04:44:13 INFO - PROCESS | 3774 | Browser inner width/height: 1024/697 04:44:13 INFO - PROCESS | 3774 | __metrics 04:44:14 ERROR - PROCESS | 3774 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 04:44:15 INFO - TEST-INFO | 3774: exit 0 04:44:15 INFO - Browser initialized. 04:44:15 INFO - Running cycle 1/1 for kraken test... 04:44:15 INFO - TEST-INFO | started process 3903 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvH0xpr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:44:27 INFO - PROCESS | 3903 | RSS: Main: 155860992 04:44:27 INFO - PROCESS | 3903 | 04:44:29 INFO - PROCESS | 3903 | Cycle 1(1): loaded http://localhost:36078/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36078/tests/kraken/driver.html?testName=audio-beat-detection) 04:44:30 INFO - PROCESS | 3903 | RSS: Main: 160997376 04:44:30 INFO - PROCESS | 3903 | 04:44:33 INFO - PROCESS | 3903 | Cycle 1(1): loaded http://localhost:36078/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36078/tests/kraken/driver.html?testName=audio-dft) 04:44:33 INFO - PROCESS | 3903 | RSS: Main: 160686080 04:44:33 INFO - PROCESS | 3903 | 04:44:36 INFO - PROCESS | 3903 | Cycle 1(1): loaded http://localhost:36078/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36078/tests/kraken/driver.html?testName=audio-fft) 04:44:37 INFO - PROCESS | 3903 | RSS: Main: 161566720 04:44:37 INFO - PROCESS | 3903 | 04:44:39 INFO - PROCESS | 3903 | Cycle 1(1): loaded http://localhost:36078/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36078/tests/kraken/driver.html?testName=audio-oscillator) 04:44:39 INFO - PROCESS | 3903 | RSS: Main: 161206272 04:44:39 INFO - PROCESS | 3903 | 04:44:42 INFO - PROCESS | 3903 | Cycle 1(1): loaded http://localhost:36078/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36078/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:44:42 INFO - PROCESS | 3903 | RSS: Main: 161005568 04:44:42 INFO - PROCESS | 3903 | 04:44:45 INFO - PROCESS | 3903 | Cycle 1(1): loaded http://localhost:36078/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36078/tests/kraken/driver.html?testName=imaging-darkroom) 04:44:46 INFO - PROCESS | 3903 | RSS: Main: 160501760 04:44:46 INFO - PROCESS | 3903 | 04:44:49 INFO - PROCESS | 3903 | Cycle 1(1): loaded http://localhost:36078/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36078/tests/kraken/driver.html?testName=imaging-desaturate) 04:44:50 INFO - PROCESS | 3903 | RSS: Main: 161366016 04:44:50 INFO - PROCESS | 3903 | 04:44:53 INFO - PROCESS | 3903 | Cycle 1(1): loaded http://localhost:36078/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36078/tests/kraken/driver.html?testName=json-parse-financial) 04:44:54 INFO - PROCESS | 3903 | RSS: Main: 161173504 04:44:54 INFO - PROCESS | 3903 | 04:44:55 INFO - PROCESS | 3903 | Cycle 1(1): loaded http://localhost:36078/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36078/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:44:55 INFO - PROCESS | 3903 | RSS: Main: 160993280 04:44:55 INFO - PROCESS | 3903 | 04:44:57 INFO - PROCESS | 3903 | Cycle 1(1): loaded http://localhost:36078/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36078/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:44:58 INFO - PROCESS | 3903 | RSS: Main: 161198080 04:44:58 INFO - PROCESS | 3903 | 04:45:00 INFO - PROCESS | 3903 | Cycle 1(1): loaded http://localhost:36078/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36078/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:45:01 INFO - PROCESS | 3903 | RSS: Main: 161308672 04:45:01 INFO - PROCESS | 3903 | 04:45:03 INFO - PROCESS | 3903 | Cycle 1(1): loaded http://localhost:36078/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36078/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:45:04 INFO - PROCESS | 3903 | RSS: Main: 161619968 04:45:04 INFO - PROCESS | 3903 | 04:45:07 INFO - PROCESS | 3903 | Cycle 1(1): loaded http://localhost:36078/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36078/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:45:07 INFO - PROCESS | 3903 | RSS: Main: 161501184 04:45:07 INFO - PROCESS | 3903 | 04:45:09 INFO - PROCESS | 3903 | Cycle 1(1): loaded http://localhost:36078/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36078/tests/kraken/driver.html?testName=ai-astar) 04:45:09 INFO - PROCESS | 3903 | RSS: Main: 161800192 04:45:09 INFO - PROCESS | 3903 | 04:45:09 INFO - PROCESS | 3903 | __start_tp_report 04:45:09 INFO - PROCESS | 3903 | _x_x_mozilla_page_load 04:45:09 INFO - PROCESS | 3903 | _x_x_mozilla_page_load_details 04:45:09 INFO - PROCESS | 3903 | |i|pagename|runs| 04:45:09 INFO - PROCESS | 3903 | |0;ai-astar;115;104;110;110;110;110;111;110;109;109 04:45:09 INFO - PROCESS | 3903 | |1;audio-beat-detection;153;124;153;181;130;158;150;126;189;128 04:45:09 INFO - PROCESS | 3903 | |2;audio-dft;162;163;162;161;161;162;162;160;164;163 04:45:09 INFO - PROCESS | 3903 | |3;audio-fft;74;74;75;188;76;75;74;75;164;75 04:45:09 INFO - PROCESS | 3903 | |4;audio-oscillator;84;84;154;83;83;84;138;84;83;141 04:45:09 INFO - PROCESS | 3903 | |5;imaging-gaussian-blur;118;117;117;117;118;117;117;117;117;117 04:45:09 INFO - PROCESS | 3903 | |6;imaging-darkroom;146;147;146;146;147;147;146;146;147;147 04:45:09 INFO - PROCESS | 3903 | |7;imaging-desaturate;100;95;96;95;95;96;95;99;95;95 04:45:09 INFO - PROCESS | 3903 | |8;json-parse-financial;51;52;53;55;52;53;53;53;52;52 04:45:09 INFO - PROCESS | 3903 | |9;json-stringify-tinderbox;61;60;60;60;62;60;60;59;64;60 04:45:09 INFO - PROCESS | 3903 | |10;stanford-crypto-aes;75;75;77;76;81;75;86;76;111;77 04:45:09 INFO - PROCESS | 3903 | |11;stanford-crypto-ccm;121;140;131;121;136;129;120;129;122;130 04:45:09 INFO - PROCESS | 3903 | |12;stanford-crypto-pbkdf2;159;153;153;158;153;158;154;154;159;156 04:45:09 INFO - PROCESS | 3903 | |13;stanford-crypto-sha256-iterative;64;67;62;60;66;60;62;63;61;60 04:45:09 INFO - PROCESS | 3903 | __end_tp_report 04:45:09 INFO - PROCESS | 3903 | __start_cc_report 04:45:09 INFO - PROCESS | 3903 | _x_x_mozilla_cycle_collect,846 04:45:09 INFO - PROCESS | 3903 | __end_cc_report 04:45:09 INFO - PROCESS | 3903 | __startTimestamp1468842309717__endTimestamp 04:45:09 INFO - PROCESS | 3903 | 04:45:09 INFO - PROCESS | 3903 | ------- Summary: start ------- 04:45:09 INFO - PROCESS | 3903 | Number of tests: 14 04:45:09 INFO - PROCESS | 3903 | 04:45:09 INFO - PROCESS | 3903 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.00 stddev:2.66 (2.4%) stddev-sans-first:2.05 04:45:09 INFO - PROCESS | 3903 | Values: 115.0 104.0 110.0 110.0 110.0 110.0 111.0 110.0 109.0 109.0 04:45:09 INFO - PROCESS | 3903 | 04:45:09 INFO - PROCESS | 3903 | [#1] audio-beat-detection Cycles:10 Average:149.20 Median:153.00 stddev:22.84 (14.9%) stddev-sans-first:24.18 04:45:09 INFO - PROCESS | 3903 | Values: 153.0 124.0 153.0 181.0 130.0 158.0 150.0 126.0 189.0 128.0 04:45:09 INFO - PROCESS | 3903 | 04:45:09 INFO - PROCESS | 3903 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.15 (0.7%) stddev-sans-first:1.22 04:45:09 INFO - PROCESS | 3903 | Values: 162.0 163.0 162.0 161.0 161.0 162.0 162.0 160.0 164.0 163.0 04:45:09 INFO - PROCESS | 3903 | 04:45:09 INFO - PROCESS | 3903 | [#3] audio-fft Cycles:10 Average:95.00 Median:75.00 stddev:43.07 (57.4%) stddev-sans-first:45.01 04:45:09 INFO - PROCESS | 3903 | Values: 74.0 74.0 75.0 188.0 76.0 75.0 74.0 75.0 164.0 75.0 04:45:09 INFO - PROCESS | 3903 | 04:45:09 INFO - PROCESS | 3903 | [#4] audio-oscillator Cycles:10 Average:101.80 Median:83.50 stddev:29.63 (35.5%) stddev-sans-first:30.72 04:45:09 INFO - PROCESS | 3903 | Values: 84.0 84.0 154.0 83.0 83.0 84.0 138.0 84.0 83.0 141.0 04:45:09 INFO - PROCESS | 3903 | 04:45:09 INFO - PROCESS | 3903 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 04:45:09 INFO - PROCESS | 3903 | Values: 118.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 04:45:09 INFO - PROCESS | 3903 | 04:45:09 INFO - PROCESS | 3903 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 04:45:09 INFO - PROCESS | 3903 | Values: 146.0 147.0 146.0 146.0 147.0 147.0 146.0 146.0 147.0 147.0 04:45:09 INFO - PROCESS | 3903 | 04:45:09 INFO - PROCESS | 3903 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:95.00 stddev:1.85 (2.0%) stddev-sans-first:1.32 04:45:09 INFO - PROCESS | 3903 | Values: 100.0 95.0 96.0 95.0 95.0 96.0 95.0 99.0 95.0 95.0 04:45:09 INFO - PROCESS | 3903 | 04:45:09 INFO - PROCESS | 3903 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:53.00 stddev:1.07 (2.0%) stddev-sans-first:0.97 04:45:09 INFO - PROCESS | 3903 | Values: 51.0 52.0 53.0 55.0 52.0 53.0 53.0 53.0 52.0 52.0 04:45:09 INFO - PROCESS | 3903 | 04:45:09 INFO - PROCESS | 3903 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:60.00 stddev:1.43 (2.4%) stddev-sans-first:1.51 04:45:09 INFO - PROCESS | 3903 | Values: 61.0 60.0 60.0 60.0 62.0 60.0 60.0 59.0 64.0 60.0 04:45:09 INFO - PROCESS | 3903 | 04:45:09 INFO - PROCESS | 3903 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:76.50 stddev:11.13 (14.5%) stddev-sans-first:11.60 04:45:09 INFO - PROCESS | 3903 | Values: 75.0 75.0 77.0 76.0 81.0 75.0 86.0 76.0 111.0 77.0 04:45:09 INFO - PROCESS | 3903 | 04:45:09 INFO - PROCESS | 3903 | [#11] stanford-crypto-ccm Cycles:10 Average:127.90 Median:129.50 stddev:6.84 (5.3%) stddev-sans-first:6.78 04:45:09 INFO - PROCESS | 3903 | Values: 121.0 140.0 131.0 121.0 136.0 129.0 120.0 129.0 122.0 130.0 04:45:09 INFO - PROCESS | 3903 | 04:45:09 INFO - PROCESS | 3903 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.70 Median:157.00 stddev:2.58 (1.6%) stddev-sans-first:2.45 04:45:09 INFO - PROCESS | 3903 | Values: 159.0 153.0 153.0 158.0 153.0 158.0 154.0 154.0 159.0 156.0 04:45:09 INFO - PROCESS | 3903 | 04:45:09 INFO - PROCESS | 3903 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:62.50 stddev:2.51 (4.0%) stddev-sans-first:2.60 04:45:09 INFO - PROCESS | 3903 | Values: 64.0 67.0 62.0 60.0 66.0 60.0 62.0 63.0 61.0 60.0 04:45:09 INFO - PROCESS | 3903 | -------- Summary: end -------- 04:45:09 INFO - PROCESS | 3903 | 04:45:10 INFO - TEST-INFO | 3903: exit 0 04:45:10 INFO - TEST-OK | kraken | took 61195ms 04:45:10 INFO - SUITE-END | took 1173s 04:45:10 INFO - Completed test suite (00:19:33) 04:45:10 INFO - javascript benchmark 04:45:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7639.675653303784, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3398.830058497075, 3409.1306716787217, 3433.75963682542, 3440.7591468597207, 3443.948340774887, 5611.551075913922, 5647.632903861246, 5717.085266357383, 5728.140778883169, 5760.222369980052, 5682.403347648499, 5709.514691251238, 5711.571632127597, 5760.2511673482495, 5774.682392468423, 5085.1863701807715, 5141.126008578532, 5188.4811518848, 5191.325127733389, 5263.657862238962, 5125.564327032207, 5129.051125541787, 5168.095583272912, 5198.9480105198845, 5265.447128051538, 5110.897782044357, 5121.1038068338075, 5133.614978876581, 5200.713960732158, 5301.920471192916, 5212.139996900507, 5221.425643179247, 5221.79112835488, 5222.216667499867, 5262.342207224097, 4988.326575912278, 5001.324821149135, 5135.12702840518, 5155.896882062375, 5203.817866374697, 5446.972765136149, 5525.834224973257, 5535.640183388107, 5549.1676248562635, 5581.274434323512, 6027.065804800219, 6065.757369705207, 6076.726547305382, 6084.726187321581, 6087.269527656709, 6034.577579569432, 6091.847703807396, 6116.235470566179, 6129.295131059941, 6131.049687298476, 5516.117421212587, 5558.055130627763, 5561.332640083176, 5561.888762224733, 5568.972155139199, 6100.48145907594, 6127.601705889103, 6145.477634401126, 6156.476699480505, 6168.784092556829, 5846.1230815377185, 5909.084091965752, 5918.852028699231, 5943.465088142088, 5993.640381577119, 5975.073863551156, 6032.065029920369, 6050.6974651267265, 6064.241969753781, 6081.8479538011015, 5893.970530147321, 6050.183225264621, 6059.575829691968, 6060.606060606046, 6065.878682426327, 5993.700314984233, 6067.150598916155, 6119.571629985859, 6168.1056246844855, 6176.907346389808, 4473.0, 4486.798094085774, 4492.820287188476, 4494.640428765691, 4515.074409745994, 3927.3912543555793, 3963.207358528306, 4048.291548978917, 4066.7153299268766, 4072.6334629883454, 5652.434756524314, 5656.434356564393, 5744.195812586241, 5828.0966450200285, 5837.737301821428, 6008.819735407945, 6057.7879774207695, 6066.545009124245, 6078.513718902477, 6080.331163572004, 5724.112762521816, 5730.226419433407, 5784.94215057844, 5786.71066446676, 5787.623804452697, 4958.0, 4991.326170966946, 4994.425641051325, 5018.899622007612, 5034.421041580265, 6303.810885673437, 6355.618662880242, 6356.745730170742, 6360.459360954371, 6360.745570177233, 6011.939880601138, 6069.514438844882, 6071.453569178795, 6083.7870674526175, 6122.724477398617, 6444.065610486547, 6490.058941453369, 6491.7403303869205, 6492.253390860112, 6507.121538592419, 6055.061465472859, 6064.3935606439, 6064.969675151596, 6069.817905462844, 6080.148779171008, 6027.668478233739, 6041.456268935817, 6072.939270607238, 6091.147239386578, 6150.354212807591, 5924.881502369843, 5960.880782384242, 5973.522118230618, 5976.581639285208, 5993.910091348721, 5915.112733090071, 5939.465448109518, 5956.821295361146, 5964.731587078679, 5991.281046274475, 5637.661740295595, 5781.248437703071, 5812.593118481665, 5826.912596311144, 5894.970525147347, 5964.433378829178, 5989.8203053908455, 5994.820155395345, 6024.277086749618, 6026.939730602813, 5772.826815195551, 5888.528917686489, 5897.321807992136, 5902.439268269508, 5906.822795316148], "value": 5588.388740818772, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.8280798568416, 649.6167261315823, 652.2433976587159, 655.1286788571201, 665.3579295979379, 34920.0, 38175.0, 47389.289160662614, 48374.27438588415, 48549.271760923526, 48396.0, 48576.75711621446, 48870.51129488704, 48941.265881011816, 49156.262656060186, 9133.223675987549, 9282.071792820732, 9294.070592940685, 9296.0, 9307.72076837696, 9147.58835852385, 9239.122283383102, 9242.12199841014, 9243.445393276392, 9263.07369263075, 9295.48874811885, 9338.953305233465, 9341.346105772598, 9343.76640583984, 9346.392484488486, 9231.815363692689, 9233.95383023084, 9291.907080929206, 9301.069893010712, 9321.906780932206, 9009.864852027225, 9081.45511269326, 9140.542972851397, 9177.0, 9181.954090229572, 45784.0, 46050.0, 46093.53906460926, 46276.305855412196, 46451.0, 3708.35103856824, 3719.200371920023, 3914.3932690432744, 3962.286788378091, 4075.735077219971, 31780.523292150636, 35847.0, 35979.82010089959, 36085.63914360875, 36176.63823361785, 4664.137134630104, 4797.808087676523, 4844.709317440965, 4864.270359446076, 4922.015596880638, 394613.0, 401251.0, 401758.991205045, 403112.0, 403492.0, 38693.22613547713, 68937.31062689409, 69524.0, 69748.6512567444, 69921.30078699147, 39423.40864887029, 41624.583754162675, 41721.79139104285, 41726.37410438846, 41760.37359439611, 17524.561885952953, 17671.38150164738, 17808.643827123644, 17829.643407131785, 17851.0, 13713.314334283246, 13909.165450073027, 13975.79036314456, 13990.930045349709, 14002.369893354824, 9252.074792520829, 9306.767330816783, 9320.394174378644, 9354.438733676001, 9390.62437502506, 3622.8913132606062, 3647.835847386874, 3650.762700424464, 3690.612485689018, 3703.2593481303848, 1061.930974486656, 1117.2793548161553, 1175.3241885915634, 1180.3331117918349, 1200.477792160413, 33301.0, 34029.14927126842, 34171.31657366839, 34235.486467703005, 34667.65332346695, 1206.9939650301692, 1259.6724851538484, 1289.8194252804615, 1298.5260379961435, 1353.1610401551102, 17159.656806863793, 17668.02825844591, 18010.28902254284, 18068.63862722738, 18119.275228990693, 628717.0, 631607.0, 652234.0, 684869.0, 1090896.0, 60788.0, 60958.99999999911, 61383.69308153431, 61392.38607613956, 61731.691341543, 1454.6508837879044, 1483.5104415542844, 1492.156931333793, 1495.8055452791068, 1496.5510346895887, 32709.345813083128, 32737.67262327346, 33127.0, 33145.50281745824, 33879.830600847825, 52200.738996304775, 52735.47264527459, 52837.471625284794, 52856.0, 53022.0, 393053.0, 393205.0, 393508.0, 393811.0, 393850.0, 28878.711212888444, 29552.55671164891, 29758.25604359908, 29825.850870745508, 29922.0, 52635.0, 52635.73682131565, 53195.202071968175, 53990.73004634952, 54585.727071365975, 43646.781766090964, 44881.55118448904, 44942.3258651127, 45309.546904530536, 46190.76904615456, 43608.56391436045, 44155.11689766251, 44245.00897459558, 44255.557444426435, 44363.55636443723, 44092.55907441013, 44883.77558112189, 45091.54908450873, 45174.54825451703, 45287.77356113198, 38484.80757596194, 38728.64449744245, 39385.60614393934, 39874.00314992148, 39955.0, 29902.401951960404, 30717.539236911016, 30775.0, 30785.538216927212, 30950.380992380477], "value": 20517.81854068167, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.4095618524529, 433.6985794872564, 437.1671964906852, 438.6359321762937, 444.27583039645396, 18606.34877779278, 19427.805721942776, 20393.694094588576, 20400.489987750312, 20414.795852041476, 18609.627807443878, 18717.0, 18792.71810922837, 19623.90188049061, 19780.10989505472, 5226.712530810813, 5393.460653934595, 5402.135658294674, 5438.91841622376, 5443.292371991635, 5279.1817268323475, 5335.386430560497, 5386.3536375634785, 5423.7830486780485, 5900.291964964189, 5798.159266906296, 5810.709464526778, 5815.127730840365, 5878.794242201524, 5889.911651325234, 5313.256144139785, 5346.625736198468, 5510.952918945388, 5823.213866128082, 5834.212381328509, 5196.610254230948, 5198.2722418861385, 5212.739363031833, 5215.165573508259, 5247.0, 11304.265222760494, 14821.036632618845, 21894.671579926315, 23209.651855222186, 23237.3028809136, 2188.2341180586827, 2209.723784526934, 2268.663276824873, 2310.3415526575013, 2529.0, 10294.845577316346, 10364.896351036468, 10472.319299245524, 10560.47197640115, 10700.732481687943, 1941.5049162463622, 2040.3878836349184, 2093.7906209379094, 2110.8944552772455, 2132.8613640113344, 84147.57926210391, 88225.0, 88811.0, 88935.0, 91088.08911910863, 11861.288322700493, 11870.703232419259, 11903.166778325607, 11936.880631193751, 12084.939575302244, 16801.0, 16855.57861053459, 16874.15629218534, 16929.576760580836, 16949.745753813702, 8813.338999575057, 8911.777205569782, 8920.776980575538, 9004.8649270261, 9040.0, 8702.521361325062, 8773.166549177946, 8788.648454061893, 8818.426802257833, 8867.822643547093, 5009.524095210949, 5027.271045698353, 5049.469805670352, 5096.872578185501, 5130.127878260705, 2055.403932859484, 2055.8869262190724, 2079.480129967508, 2105.557832855087, 2118.5445129297277, 1062.0600768319937, 1062.8086944349936, 1108.490094556513, 1135.500379832871, 1184.3545267828881, 17845.910770446324, 20915.581688366146, 21179.47051323729, 21215.0, 21591.46021349479, 1028.9742756430999, 1112.3270421395102, 1155.439611788282, 1190.345310079453, 1193.7612477504533, 11250.831237531444, 11634.592789252336, 11654.650360489199, 11677.0, 11698.2981021139, 499720.0, 513747.0, 517246.0, 523588.0, 524622.0, 61154.38845611576, 63495.6825215871, 76263.61868190735, 90626.54686726524, 94848.0, 1108.8336749487642, 1137.0960086731068, 1151.3552410649895, 1160.2458402038742, 1175.0364700945142, 18294.268229271212, 18687.43937681872, 18745.90627046856, 18838.52903677419, 18852.905735471235, 41423.34306627822, 42775.57224427716, 43015.354769677855, 43651.90870228269, 44389.77805110954, 58886.0, 60436.395636043075, 60450.395496044475, 62211.37788622237, 62992.0, 6251.78118765841, 7831.686732530635, 8261.752147435587, 8306.584670766559, 8358.707445239388, 9741.172000380047, 13440.260785656883, 13732.382042808298, 13750.793738094137, 13898.930505347813, 12337.753244935231, 12355.3822308886, 12400.56598019065, 12594.811077834023, 12634.620961371174, 11673.241239319417, 11870.881291187323, 11985.34080625574, 11993.0, 12043.698907527381, 12283.324417156784, 12563.0, 12656.6835829105, 12775.425105870072, 12876.549320773727, 8295.543745094077, 8420.36847236472, 8430.578471076544, 8459.323254139532, 8484.109168537214, 11280.943595282299, 12701.36493175356, 12715.491380344683, 12801.487940482277, 12860.164089334163], "value": 9492.574730610888, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1438.798568200452, 1493.9178345191015, 1661.2939500712203, 1831.5146486181172, 1838.8436982856465, 8452.619632116553, 9042.547872606376, 9339.859902101465, 9895.455749933752, 9906.801863962717, 8955.820883582324, 9315.627374905012, 9347.813043739121, 9367.391119577223, 9380.57787399567, 2373.7744914233162, 2441.890114944823, 2453.5460939726117, 2456.091246238894, 2457.373369790701, 2408.0488207158164, 2436.2447641231274, 2503.7496250374907, 2505.1482495951373, 2506.9122580709677, 2451.705795304566, 2452.264320703791, 2480.6775119234476, 2491.950160996779, 2497.962530562043, 2400.519896020794, 2420.6369044643357, 2435.3546310227803, 2446.3150317911013, 2461.6307553867064, 2368.7749663781915, 2393.102586530051, 2426.46617744096, 2427.4052857050137, 2435.585950388438, 9118.0, 9198.218151457135, 9233.861492077624, 9242.6302947882, 9264.6294148234, 5548.86127846803, 5673.461021202979, 5710.914336284959, 5715.6284841485585, 5717.0, 3613.5483064616924, 3682.3371793077235, 3754.5682246541724, 3795.760501304244, 3837.194189220267, 1267.1446773427992, 1278.1755767529985, 1303.120393734235, 1315.0400207848324, 1317.3084130831294, 13601.727965440636, 13647.317634118353, 13669.248191349472, 13723.039387242898, 13856.307184640727, 5079.923801142986, 5150.948490515122, 5201.3238279024245, 5217.06092903281, 5224.216367544898, 11291.943540282246, 11361.829572556418, 11373.715657108638, 11426.600068997544, 11608.24546404481, 5643.971780141073, 5664.122061080539, 5737.3688894221605, 5752.654840709571, 5834.591578589543, 4710.929336059962, 5078.695278283315, 5191.974040129775, 5199.63602547818, 5298.761555730001, 4463.732176069381, 4566.611837993742, 4588.7246765194195, 4596.540345965377, 4602.05657840142, 1380.882624976888, 1395.3581352577726, 1403.2702994442832, 1409.1545072956144, 1415.1579810013027, 1067.2955849139687, 1070.550368845087, 1084.4848696869083, 1095.6055819904827, 1104.6575561575937, 6727.327267273331, 6816.693248803816, 6910.792676219721, 6914.51598388108, 6946.79159625212, 454.9772511374418, 464.0255463526567, 469.9036697477009, 472.4425178289651, 491.4544855210713, 4458.041521072985, 4697.10754956564, 4717.528247175255, 4732.976335118303, 4739.881502962454, 11307.49116289769, 11321.603743868925, 11785.528578856922, 11889.464974076187, 11949.044076473861, 11992.0, 12004.099692523096, 12042.39788010596, 12068.275903445821, 12172.330521821385, 8920.8661870072, 9103.590338434786, 9111.17999380059, 9137.086291370942, 9152.588133534007, 6661.500387471056, 6863.10779598649, 6867.278935711678, 6884.208316043719, 6951.304869513008, 10970.067544258827, 11014.559417623526, 11055.72360690989, 11061.557537698402, 11255.774884502427, 10915.83626245591, 11155.83266251023, 11196.888031119584, 11208.719782005515, 11250.606228781953, 8041.316488098577, 8237.917620823955, 8279.172082791914, 8503.489790612583, 8530.0, 9378.249740020645, 9620.615175392906, 9630.759231019001, 9736.41581505112, 9745.12293893553, 8284.83430331402, 8358.498490090615, 8413.831723365622, 8512.53181075022, 8783.472991620523, 8094.797630059295, 8162.306203972729, 8490.150984901707, 8529.616167272612, 8658.78353041179, 7811.882821757565, 7903.68385264583, 8018.879716804136, 8021.037475502977, 8026.237507436784, 5690.516306113861, 5952.779680165642, 5961.672108033927, 6007.54943379257, 6119.265688117454, 5938.138969849434, 5994.220751302303, 6004.5796794225735, 6066.211392518944, 6152.261728592597], "value": 4991.662654468891, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.4041848021402, 349.5839950458954, 356.37634140254545, 363.6363636363638, 363.63999640356053, 5631.944340315786, 5677.233573467581, 5799.652020878751, 5822.4177582241755, 5885.087346612352, 5709.314882214129, 5724.942750572493, 5725.368270043038, 5741.971290143554, 5743.138529220619, 4440.888977775549, 4455.621272191867, 4468.932966005513, 4469.837842161029, 4477.328400739882, 4381.211381951263, 4432.160653328865, 4433.866983990485, 4441.75570343631, 4502.279635258359, 4393.165298593257, 4400.97799511002, 4403.955960440403, 4426.557344265564, 4442.155990361837, 4447.310666846644, 4459.859267551561, 4464.352668862996, 4465.665075119379, 4466.932996005063, 3671.3575124353133, 3868.207017561393, 3987.7469229885314, 3988.222296652154, 3999.8200080996426, 5448.509634132947, 5454.563634909237, 5465.480779325958, 5533.142362933751, 5547.5007249347345, 5017.49825017499, 5052.545270925634, 5054.418741844698, 5069.569086627641, 5095.643304968654, 5697.974364614368, 5997.850053748692, 5997.970010149921, 6005.978983572803, 6008.549358798107, 4276.2516559601945, 4285.400043993844, 4288.421063156465, 4293.334533147367, 4299.269124248885, 6236.438720515175, 6247.4377306042215, 6259.311475737711, 6288.52836037299, 6289.433950944483, 4257.8509752158525, 4331.350297455407, 4336.6313863321975, 4342.913141737147, 4349.217140914666, 4434.379186913835, 4441.866743997685, 4458.331250312479, 4462.9107417851465, 4474.910501789946, 5037.471065538139, 5042.067217564762, 5049.2426136079885, 5098.719570423588, 5115.71863547501, 5794.913076303858, 5846.6784326862435, 5999.59009632736, 6018.458338749446, 6051.727672254759, 1489.5829167833024, 1517.3778750712156, 1524.885633577486, 1524.9771253431206, 1525.8474152584652, 963.937344072633, 981.1954197557934, 988.5057471264367, 989.0702739424918, 994.005994005994, 5248.819015721432, 5270.446603106619, 5295.814646487354, 5345.86635334112, 5359.973200133974, 5444.401115877329, 5478.931798193024, 5497.587680923947, 5502.2296878437055, 5523.585731070186, 4978.6017118630425, 5220.973895130576, 5234.633575649668, 5267.841964741064, 5298.258243845865, 2977.955330670042, 2994.3562134141266, 2997.2207226121363, 3005.218643152796, 3019.275373910246, 5759.5521903190975, 5763.625364351387, 5763.933672270643, 5837.970810146007, 5859.44335288147, 5962.2249107615735, 6377.649229292433, 6417.197850268716, 6428.260750013715, 6429.549931504844, 6548.738050478023, 6590.275069742324, 6592.472602191813, 6595.340465953366, 6617.371349721865, 6038.0, 6178.505719542336, 6304.3380445054445, 6308.71610777507, 6333.778317759041, 6151.585135418968, 6155.630662160284, 6215.689215539295, 6228.719707613078, 6228.937710623017, 6385.425311721968, 6505.772297969548, 6516.761815255087, 6541.476681865534, 6634.175601709569, 4387.495438024668, 4393.714408563433, 4410.448693913261, 4436.467623885154, 4455.331700244989, 6045.576809623284, 6110.236220472441, 6268.905966410416, 6300.810975670737, 6311.400416960381, 6019.217501724747, 6057.57596968208, 6077.389491784592, 6079.665618391031, 6091.7563297467605, 6039.879202416015, 6075.787347442818, 6077.908831367621, 6103.917521651538, 6105.267367915879, 5661.66030038199, 5981.192539007352, 5985.551083668829, 6001.019663510943, 6027.517798576016, 6133.417325354084, 6161.322254552086, 6163.506919446523, 6164.815055548341, 6181.84545386369, 5496.31296087989, 5924.52603791687, 5948.583599148191, 5952.76771210796, 6028.186194863637], "value": 4528.535807160358, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [785.1951749456806, 786.7757689058619, 809.8947136872206, 850.9404341696082, 915.7802127489405, 15929.442469513584, 16026.198690065508, 16074.758878616802, 16380.672386552262, 17263.56841078972, 16038.919805400987, 16105.83894161058, 16142.0, 16147.0, 16201.594960126004, 848.0713618587637, 877.1491653096487, 877.5787621941472, 881.6693739847557, 881.9294456443469, 846.022843615625, 855.589317127779, 856.8543347630917, 857.1128881607538, 858.3262139220682, 892.4154678685471, 892.8526793079134, 896.3770179725094, 897.161154320709, 897.6499165325529, 884.8141890203001, 885.707716453572, 886.521278509604, 888.9333300002526, 891.2869704236617, 653.9901901471482, 654.8559316950264, 657.011198146786, 658.3778329478645, 658.8945768676989, 16806.663866722596, 16882.0, 16961.915190424093, 16997.57506062346, 17002.0, 15038.699226015418, 15080.622984425367, 15547.689046219126, 15655.765163522556, 15766.684666306724, 12682.55611053618, 12929.133701150278, 12960.80558791619, 13145.802812957812, 13220.537281195113, 4062.939055914164, 4209.5790420957965, 4263.339182426729, 4284.67864910133, 4285.764282964436, 78225.60887195585, 80981.0, 81142.18857811406, 81783.0, 82057.58971205166, 12124.454399552042, 12151.513939442324, 12253.0, 12285.815712764315, 12459.563915262923, 22884.4278893029, 22911.88544057269, 22963.0, 23028.194013209457, 23230.65154022691, 8949.060348663297, 9026.323025772961, 9181.862272065924, 9405.388649737744, 9526.333156678966, 4939.530744579331, 5114.872128196825, 5131.435542090367, 5168.8449346519665, 5197.7141257231215, 3800.7529510582276, 3925.0579860833764, 3956.40653901917, 3967.0, 3969.0, 638.5913015669975, 644.291279592454, 647.5078940005629, 648.0732552450041, 652.7519542573887, 660.6828722213269, 700.6426722371627, 715.5098757351232, 726.8473620539746, 746.4289818289013, 11170.553177872956, 11343.659690209306, 11389.338841747143, 11506.827397589042, 11641.243319184226, 627.6234259444296, 636.8726254749068, 676.8477092654211, 751.5490705576719, 768.7347864986571, 4979.402471703346, 5077.390713114376, 5101.20931255656, 5121.718305493159, 5143.305653736773, 73076.269237308, 74464.62767686235, 98304.50847745716, 100185.49907250417, 101353.0, 98217.50891245641, 98277.0, 102132.48933755283, 102864.0, 103740.48129759454, 93551.0, 93651.53174234086, 96360.0, 97550.51224743831, 98119.0, 10569.365838049742, 10711.303765255234, 10711.8928810714, 10822.621208257673, 10986.670399888017, 47452.52547474481, 49073.5092649069, 51432.22851657153, 52062.0, 55247.0, 73809.6309518449, 81917.0, 82326.0, 84554.57722711594, 86008.0, 14270.429182832571, 14422.0, 14553.636159096108, 14618.926905365404, 14642.633934151732, 16097.114658693885, 16110.67778644444, 16116.27476763525, 16151.434699785452, 16557.83442165563, 14986.700265994838, 15600.453984110502, 15755.606109846887, 15777.368905243662, 15821.208939553206, 14480.927595361956, 14880.0, 15149.318280677617, 15399.846001540289, 15435.768463473281, 14995.775063374276, 15197.31612077437, 15659.217039148225, 16077.437289694804, 16109.516714498584, 11493.252938558968, 11517.769644607228, 11595.188336816342, 11689.298642081503, 11903.226290291102, 12200.267983920992, 12410.0, 12435.0, 12609.621711348675, 12636.55772047974], "value": 8079.8719687824605, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1517.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 104.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 109.0, 109.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 124.0, 153.0, 181.0, 130.0, 158.0, 150.0, 126.0, 189.0, 128.0], "value": 149.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 161.0, 161.0, 162.0, 162.0, 160.0, 164.0, 163.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 188.0, 76.0, 75.0, 74.0, 75.0, 164.0, 75.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 154.0, 83.0, 83.0, 84.0, 138.0, 84.0, 83.0, 141.0], "value": 101.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 99.0, 95.0, 95.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 53.0, 55.0, 52.0, 53.0, 53.0, 53.0, 52.0, 52.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 60.0, 62.0, 60.0, 60.0, 59.0, 64.0, 60.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 76.0, 81.0, 75.0, 86.0, 76.0, 111.0, 77.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 140.0, 131.0, 121.0, 136.0, 129.0, 120.0, 129.0, 122.0, 130.0], "value": 127.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 153.0, 153.0, 158.0, 153.0, 158.0, 154.0, 154.0, 159.0, 156.0], "value": 155.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 62.0, 60.0, 66.0, 60.0, 62.0, 63.0, 61.0, 60.0], "value": 62.5, "unit": "score"}]}]} 04:45:10 INFO - Return code: 0 04:45:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:45:11 ERROR - # TBPL SUCCESS # 04:45:11 INFO - Running post-action listener: _resource_record_post_action 04:45:11 INFO - ##### 04:45:11 INFO - ##### Finished run-tests step (success) 04:45:11 INFO - ##### 04:45:11 INFO - Running post-run listener: _resource_record_post_run 04:45:11 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 10358784; Write bytes: 392884224; Read time: 1580; Write time: 347552 04:45:11 INFO - TinderboxPrint: CPU usage
13.4% 04:45:11 INFO - TinderboxPrint: I/O read bytes / time
10,358,784 / 1,580 04:45:11 INFO - TinderboxPrint: I/O write bytes / time
392,884,224 / 347,552 04:45:11 INFO - TinderboxPrint: CPU idle
8,230.6 (86.6%) 04:45:11 INFO - TinderboxPrint: CPU user
1,215.1 (12.8%) 04:45:11 INFO - TinderboxPrint: Swap in / out
0 / 0 04:45:11 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 15486976; Read time: 0; Write time: 8140 04:45:11 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8597504; Write bytes: 377397248; Read time: 1532; Write time: 339412 04:45:11 INFO - Running post-run listener: _upload_blobber_files 04:45:11 INFO - Blob upload gear active. 04:45:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:45:11 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:45:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:45:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:45:12 INFO - (blobuploader) - INFO - Open directory for files ... 04:45:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:45:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:45:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:45:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:45:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:45:13 INFO - (blobuploader) - INFO - Done attempting. 04:45:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:45:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:45:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:45:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:45:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:45:13 INFO - (blobuploader) - INFO - Done attempting. 04:45:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:45:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:45:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:45:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:45:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:45:19 INFO - (blobuploader) - INFO - Done attempting. 04:45:19 INFO - (blobuploader) - INFO - Iteration through files over. 04:45:19 INFO - Return code: 0 04:45:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:45:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:45:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/19cbdc74ec02f7f91b4137758b8b6ad2e6ddcaf79308550c6181fb85ea73f7c7bcc0bb4fcc6c9ab6170ba660e3951e884cfd6473f0143d36098de84788cd3d51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/849bbf6b7c9e6571d19a2a6adcd00c212b89457141426279f99f61cbd8fd25dec2049b826d1af5dcb687d2e0b9898c765e222a9e34abca827f17124f650beaff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b08e29085b111541e6faae273c6a1b18e749581971251eadf61b9e8fb20b090266d4293ecc3cba1d81948cc71643aeb118451404d1bf38810904fbe8ab4981b"} 04:45:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:45:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:45:19 INFO - Contents: 04:45:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/19cbdc74ec02f7f91b4137758b8b6ad2e6ddcaf79308550c6181fb85ea73f7c7bcc0bb4fcc6c9ab6170ba660e3951e884cfd6473f0143d36098de84788cd3d51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/849bbf6b7c9e6571d19a2a6adcd00c212b89457141426279f99f61cbd8fd25dec2049b826d1af5dcb687d2e0b9898c765e222a9e34abca827f17124f650beaff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b08e29085b111541e6faae273c6a1b18e749581971251eadf61b9e8fb20b090266d4293ecc3cba1d81948cc71643aeb118451404d1bf38810904fbe8ab4981b"} 04:45:19 INFO - Running post-run listener: copy_logs_to_upload_dir 04:45:19 INFO - Copying logs to upload dir... 04:45:19 INFO - mkdir: /builds/slave/test/build/upload/logs 04:45:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.936433 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-18 04:45:19.607899) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 04:45:19.611804) ========= 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=62c568580acbfdaac3eec7be000001dc-1468841072.408528-2080761596 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/19cbdc74ec02f7f91b4137758b8b6ad2e6ddcaf79308550c6181fb85ea73f7c7bcc0bb4fcc6c9ab6170ba660e3951e884cfd6473f0143d36098de84788cd3d51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/849bbf6b7c9e6571d19a2a6adcd00c212b89457141426279f99f61cbd8fd25dec2049b826d1af5dcb687d2e0b9898c765e222a9e34abca827f17124f650beaff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b08e29085b111541e6faae273c6a1b18e749581971251eadf61b9e8fb20b090266d4293ecc3cba1d81948cc71643aeb118451404d1bf38810904fbe8ab4981b"} build_url:https://queue.taskcluster.net/v1/task/W2CACFwkQ3ymcQtJCB-13Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011255 build_url: 'https://queue.taskcluster.net/v1/task/W2CACFwkQ3ymcQtJCB-13Q/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/19cbdc74ec02f7f91b4137758b8b6ad2e6ddcaf79308550c6181fb85ea73f7c7bcc0bb4fcc6c9ab6170ba660e3951e884cfd6473f0143d36098de84788cd3d51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/849bbf6b7c9e6571d19a2a6adcd00c212b89457141426279f99f61cbd8fd25dec2049b826d1af5dcb687d2e0b9898c765e222a9e34abca827f17124f650beaff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b08e29085b111541e6faae273c6a1b18e749581971251eadf61b9e8fb20b090266d4293ecc3cba1d81948cc71643aeb118451404d1bf38810904fbe8ab4981b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 04:45:19.636687) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 04:45:19.637044) ========= 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=62c568580acbfdaac3eec7be000001dc-1468841072.408528-2080761596 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 04:45:19.721274) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 04:45:19.721621) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 04:45:19.721929) ========= ========= Total master_lag: 0.15 =========