builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1467543420.61 results: success (0) buildid: 20160703010322 builduid: f7313ecac01843a8a01318539af3a21a revision: 49b4519a8d2e21e42649c9317e1d687af949bffd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-03 03:57:00.609658) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-03 03:57:00.610183) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-03 03:57:00.610477) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-03 03:57:00.673950) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:57:00.674324) ========= 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=df17445c3590ff7897617a0e00000225-1467542753.676176-570352329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-03 03:57:01-- 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% 46.9M=0s 2016-07-03 03:57:01 (46.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085623 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:57:00.778838) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:57:00.779173) ========= 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=df17445c3590ff7897617a0e00000225-1467542753.676176-570352329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021074 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:57:00.837372) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:57:00.837740) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 49b4519a8d2e21e42649c9317e1d687af949bffd --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 49b4519a8d2e21e42649c9317e1d687af949bffd --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=df17445c3590ff7897617a0e00000225-1467542753.676176-570352329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-03 03:57:01,346 truncating revision to first 12 chars 2016-07-03 03:57:01,346 Setting DEBUG logging. 2016-07-03 03:57:01,346 attempt 1/10 2016-07-03 03:57:01,346 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/49b4519a8d2e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-03 03:57:01,816 unpacking tar archive at: mozilla-aurora-49b4519a8d2e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.809963 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:57:01.671671) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-03 03:57:01.672010) ========= script_repo_revision: 49b4519a8d2e21e42649c9317e1d687af949bffd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-03 03:57:01.672471) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-03 03:57:01.672762) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-03 03:57:01.689095) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-03 03:57:01.689481) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1467542753.676176-570352329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:57:02 INFO - MultiFileLogger online at 20160703 03:57:02 in /builds/slave/test 03:57:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:57:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:57:02 INFO - {'append_to_log': False, 03:57:02 INFO - 'base_work_dir': '/builds/slave/test', 03:57:02 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:57:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:57:02 INFO - 'branch': 'Mozilla-Aurora', 03:57:02 INFO - 'buildbot_json_path': 'buildprops.json', 03:57:02 INFO - 'config_files': ('talos/linux_config.py',), 03:57:02 INFO - 'default_actions': ('clobber', 03:57:02 INFO - 'read-buildbot-config', 03:57:02 INFO - 'download-and-extract', 03:57:02 INFO - 'populate-webroot', 03:57:02 INFO - 'create-virtualenv', 03:57:02 INFO - 'install', 03:57:02 INFO - 'run-tests'), 03:57:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:57:02 INFO - 'download_minidump_stackwalk': True, 03:57:02 INFO - 'download_symbols': 'ondemand', 03:57:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:57:02 INFO - 'tooltool.py': '/tools/tooltool.py', 03:57:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:57:02 INFO - '/tools/misc-python/virtualenv.py')}, 03:57:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:57:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:57:02 INFO - 'installer_path': 'installer.exe', 03:57:02 INFO - 'log_level': 'info', 03:57:02 INFO - 'log_name': 'talos', 03:57:02 INFO - 'log_to_console': True, 03:57:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:57:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:57:02 INFO - 'opt_config_files': (), 03:57:02 INFO - 'pip_index': False, 03:57:02 INFO - 'sps_profile': False, 03:57:02 INFO - 'sps_profile_interval': 0, 03:57:02 INFO - 'suite': 'dromaeojs', 03:57:02 INFO - 'system_bits': '32', 03:57:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:57:02 INFO - 'title': 'talos-linux64-ix-021', 03:57:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:57:02 INFO - 'use_talos_json': True, 03:57:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:57:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:57:02 INFO - 'work_dir': 'build'} 03:57:02 INFO - ##### 03:57:02 INFO - ##### Running clobber step. 03:57:02 INFO - ##### 03:57:02 INFO - Running pre-action listener: _resource_record_pre_action 03:57:02 INFO - Running main action method: clobber 03:57:02 INFO - rmtree: /builds/slave/test/build 03:57:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:57:03 INFO - Running post-action listener: _resource_record_post_action 03:57:03 INFO - ##### 03:57:03 INFO - ##### Finished clobber step (success) 03:57:03 INFO - ##### 03:57:03 INFO - ##### 03:57:03 INFO - ##### Running read-buildbot-config step. 03:57:03 INFO - ##### 03:57:03 INFO - Running pre-action listener: _resource_record_pre_action 03:57:03 INFO - Running main action method: read_buildbot_config 03:57:03 INFO - Using buildbot properties: 03:57:03 INFO - { 03:57:03 INFO - "project": "", 03:57:03 INFO - "product": "firefox", 03:57:03 INFO - "script_repo_revision": "production", 03:57:03 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:57:03 INFO - "repository": "", 03:57:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:57:03 INFO - "buildid": "20160703010322", 03:57:03 INFO - "pgo_build": "True", 03:57:03 INFO - "basedir": "/builds/slave/test", 03:57:03 INFO - "buildnumber": 341, 03:57:03 INFO - "slavename": "talos-linux64-ix-021", 03:57:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:57:03 INFO - "platform": "ubuntu64_hw", 03:57:03 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:57:03 INFO - "branch": "mozilla-aurora", 03:57:03 INFO - "repo_path": "releases/mozilla-aurora", 03:57:03 INFO - "revision": "49b4519a8d2e21e42649c9317e1d687af949bffd", 03:57:03 INFO - "stage_platform": "linux64-pgo", 03:57:03 INFO - "builduid": "f7313ecac01843a8a01318539af3a21a", 03:57:03 INFO - "slavebuilddir": "test" 03:57:03 INFO - } 03:57:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/cGYNYlCVR4qILWx_V2WL6A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:57:03 INFO - Running post-action listener: _resource_record_post_action 03:57:03 INFO - ##### 03:57:03 INFO - ##### Finished read-buildbot-config step (success) 03:57:03 INFO - ##### 03:57:03 INFO - ##### 03:57:03 INFO - ##### Running download-and-extract step. 03:57:03 INFO - ##### 03:57:03 INFO - Running pre-action listener: _resource_record_pre_action 03:57:03 INFO - Running main action method: download_and_extract 03:57:03 INFO - mkdir: /builds/slave/test/build/tests 03:57: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')]} 03:57:03 INFO - https://queue.taskcluster.net/v1/task/cGYNYlCVR4qILWx_V2WL6A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:57:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGYNYlCVR4qILWx_V2WL6A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:57:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGYNYlCVR4qILWx_V2WL6A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:57:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGYNYlCVR4qILWx_V2WL6A/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 03:57:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGYNYlCVR4qILWx_V2WL6A/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 03:57:05 INFO - Downloaded 1361 bytes. 03:57:05 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:57:05 INFO - Using the following test package requirements: 03:57:05 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:57:05 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:57:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:57:05 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:57:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:57:05 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:57:05 INFO - u'jsshell-linux-x86_64.zip'], 03:57:05 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:57:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:57:05 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:57:05 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:57:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:57:05 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:57:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:57:05 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:57:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:57:05 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:57:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:57:05 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:57: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')]} 03:57:05 INFO - https://queue.taskcluster.net/v1/task/cGYNYlCVR4qILWx_V2WL6A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:57:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGYNYlCVR4qILWx_V2WL6A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:57:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGYNYlCVR4qILWx_V2WL6A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:57:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGYNYlCVR4qILWx_V2WL6A/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 03:57:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGYNYlCVR4qILWx_V2WL6A/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 03:57:07 INFO - Downloaded 24526042 bytes. 03:57:07 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'] 03:57:07 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 03:57:08 INFO - Return code: 0 03:57:08 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 03:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:08 INFO - https://queue.taskcluster.net/v1/task/cGYNYlCVR4qILWx_V2WL6A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:57:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGYNYlCVR4qILWx_V2WL6A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:57:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGYNYlCVR4qILWx_V2WL6A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:57:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGYNYlCVR4qILWx_V2WL6A/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 03:57:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGYNYlCVR4qILWx_V2WL6A/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 03:57:13 INFO - Downloaded 24526042 bytes. 03:57:13 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'] 03:57:13 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 03:57:15 INFO - Return code: 0 03:57:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:15 INFO - https://queue.taskcluster.net/v1/task/cGYNYlCVR4qILWx_V2WL6A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:57:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGYNYlCVR4qILWx_V2WL6A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:57:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGYNYlCVR4qILWx_V2WL6A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:57:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGYNYlCVR4qILWx_V2WL6A/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 03:57:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGYNYlCVR4qILWx_V2WL6A/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 03:57:16 INFO - Downloaded 10833369 bytes. 03:57:16 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'] 03:57:16 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 03:57:16 INFO - Return code: 0 03:57: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')]} 03:57:16 INFO - https://queue.taskcluster.net/v1/task/cGYNYlCVR4qILWx_V2WL6A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:57:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGYNYlCVR4qILWx_V2WL6A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:57:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGYNYlCVR4qILWx_V2WL6A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:57:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGYNYlCVR4qILWx_V2WL6A/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 03:57:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cGYNYlCVR4qILWx_V2WL6A/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 03:57:18 INFO - Downloaded 63645688 bytes. 03:57:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cGYNYlCVR4qILWx_V2WL6A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:57:18 INFO - mkdir: /builds/slave/test/properties 03:57:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:57:18 INFO - Writing to file /builds/slave/test/properties/build_url 03:57:18 INFO - Contents: 03:57:18 INFO - build_url:https://queue.taskcluster.net/v1/task/cGYNYlCVR4qILWx_V2WL6A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:57:19 INFO - Running post-action listener: _resource_record_post_action 03:57:19 INFO - Running post-action listener: set_extra_try_arguments 03:57:19 INFO - ##### 03:57:19 INFO - ##### Finished download-and-extract step (success) 03:57:19 INFO - ##### 03:57:19 INFO - ##### 03:57:19 INFO - ##### Running populate-webroot step. 03:57:19 INFO - ##### 03:57:19 INFO - Running pre-action listener: _resource_record_pre_action 03:57:19 INFO - Running main action method: populate_webroot 03:57:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:57:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:57:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:57:19 INFO - '--tppagecycles', 03:57:19 INFO - '7'], 03:57:19 INFO - 'tests': ['tsvgm']}}, 03:57:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:57:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:57:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:57:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:57:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:57:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:57:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:19 INFO - 'talos_options': ['--disable-e10s'], 03:57:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:57:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:57:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:19 INFO - 'talos_options': ['--disable-e10s'], 03:57:19 INFO - 'tests': ['damp', 'tps']}, 03:57:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:19 INFO - 'tests': ['damp', 'tps']}, 03:57:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:57:19 INFO - 'tests': ['dromaeo_dom']}, 03:57:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:57:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:57:19 INFO - 'tests': ['a11yr', 03:57:19 INFO - 'ts_paint', 03:57:19 INFO - 'tpaint', 03:57:19 INFO - 'sessionrestore', 03:57:19 INFO - 'sessionrestore_no_auto_restore', 03:57:19 INFO - 'tabpaint']}, 03:57:19 INFO - 'other-e10s': {'tests': ['a11yr', 03:57:19 INFO - 'ts_paint', 03:57:19 INFO - 'tpaint', 03:57:19 INFO - 'sessionrestore', 03:57:19 INFO - 'sessionrestore_no_auto_restore', 03:57:19 INFO - 'tabpaint']}, 03:57:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:57:19 INFO - 'ts_paint', 03:57:19 INFO - 'tpaint', 03:57:19 INFO - 'sessionrestore', 03:57:19 INFO - 'sessionrestore_no_auto_restore', 03:57:19 INFO - 'tabpaint']}, 03:57:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:57:19 INFO - 'ts_paint', 03:57:19 INFO - 'tpaint', 03:57:19 INFO - 'sessionrestore', 03:57:19 INFO - 'sessionrestore_no_auto_restore', 03:57:19 INFO - 'tabpaint']}, 03:57:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:57:19 INFO - 'tests': ['a11yr', 03:57:19 INFO - 'ts_paint', 03:57:19 INFO - 'tpaint', 03:57:19 INFO - 'sessionrestore', 03:57:19 INFO - 'sessionrestore_no_auto_restore', 03:57:19 INFO - 'tabpaint']}, 03:57:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:57:19 INFO - 'tests': ['a11yr', 03:57:19 INFO - 'ts_paint', 03:57:19 INFO - 'tpaint', 03:57:19 INFO - 'sessionrestore', 03:57:19 INFO - 'sessionrestore_no_auto_restore', 03:57:19 INFO - 'tabpaint']}, 03:57:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:57:19 INFO - 'tests': ['tsvgx', 03:57:19 INFO - 'tsvgr_opacity', 03:57:19 INFO - 'tart', 03:57:19 INFO - 'tscrollx', 03:57:19 INFO - 'cart']}, 03:57:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:57:19 INFO - 'tsvgr_opacity', 03:57:19 INFO - 'tart', 03:57:19 INFO - 'tscrollx', 03:57:19 INFO - 'cart']}, 03:57:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:19 INFO - 'talos_options': ['--disable-e10s'], 03:57:19 INFO - 'tests': ['tp5o']}, 03:57:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:19 INFO - 'tests': ['tp5o']}, 03:57:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:19 INFO - 'talos_options': ['--disable-e10s', 03:57:19 INFO - '--xperf_path', 03:57:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:57:19 INFO - 'tests': ['tp5n']}, 03:57:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:19 INFO - 'talos_options': ['--xperf_path', 03:57:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:57:19 INFO - 'tests': ['tp5n']}}, 03:57:19 INFO - 'talos.zip': {'path': '', 03:57:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:57:19 INFO - Running post-action listener: _resource_record_post_action 03:57:19 INFO - ##### 03:57:19 INFO - ##### Finished populate-webroot step (success) 03:57:19 INFO - ##### 03:57:19 INFO - ##### 03:57:19 INFO - ##### Running create-virtualenv step. 03:57:19 INFO - ##### 03:57:19 INFO - Running pre-action listener: _resource_record_pre_action 03:57:19 INFO - Running main action method: create_virtualenv 03:57:19 INFO - Creating virtualenv /builds/slave/test/build/venv 03:57:19 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:57:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:57:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:57:19 INFO - Using real prefix '/usr' 03:57:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:57:19 INFO - Installing distribute.............................................................................................................................................................................................done. 03:57:21 INFO - Installing pip.................done. 03:57:21 INFO - Return code: 0 03:57:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:21 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 0x7fa2bde5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2450350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24df1c0>, '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 0x24e00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e0550>, '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': 'df17445c3590ff7897617a0e00000225-1467542753.676176-570352329', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:57:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:57:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:57:21 INFO - Using env: {'DISPLAY': ':0', 03:57:21 INFO - 'HOME': '/home/cltbld', 03:57:21 INFO - 'LANG': 'en_US.UTF-8', 03:57:21 INFO - 'LANGUAGE': 'en_US:en', 03:57:21 INFO - 'LOGNAME': 'cltbld', 03:57:21 INFO - 'MAIL': '/var/mail/cltbld', 03:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:21 INFO - 'MOZ_NO_REMOTE': '1', 03:57:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:21 INFO - 'NO_EM_RESTART': '1', 03:57:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:21 INFO - 'PWD': '/builds/slave/test', 03:57:21 INFO - 'SHELL': '/bin/bash', 03:57:21 INFO - 'SHLVL': '1', 03:57:21 INFO - 'TERM': 'linux', 03:57:21 INFO - 'TMOUT': '86400', 03:57:21 INFO - 'USER': 'cltbld', 03:57:21 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467542753.676176-570352329', 03:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:21 INFO - '_': '/tools/buildbot/bin/python'} 03:57:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:57:22 INFO - Cleaning up... 03:57:22 INFO - Return code: 0 03:57:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:22 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 0x7fa2bde5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2450350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24df1c0>, '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 0x24e00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e0550>, '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': 'df17445c3590ff7897617a0e00000225-1467542753.676176-570352329', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:57:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:57:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:57:22 INFO - Using env: {'DISPLAY': ':0', 03:57:22 INFO - 'HOME': '/home/cltbld', 03:57:22 INFO - 'LANG': 'en_US.UTF-8', 03:57:22 INFO - 'LANGUAGE': 'en_US:en', 03:57:22 INFO - 'LOGNAME': 'cltbld', 03:57:22 INFO - 'MAIL': '/var/mail/cltbld', 03:57:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:22 INFO - 'MOZ_NO_REMOTE': '1', 03:57:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:22 INFO - 'NO_EM_RESTART': '1', 03:57:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:22 INFO - 'PWD': '/builds/slave/test', 03:57:22 INFO - 'SHELL': '/bin/bash', 03:57:22 INFO - 'SHLVL': '1', 03:57:22 INFO - 'TERM': 'linux', 03:57:22 INFO - 'TMOUT': '86400', 03:57:22 INFO - 'USER': 'cltbld', 03:57:22 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467542753.676176-570352329', 03:57:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:22 INFO - '_': '/tools/buildbot/bin/python'} 03:57:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:22 INFO - Downloading/unpacking psutil>=3.1.1 03:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:57:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:57:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:57:24 INFO - Installing collected packages: psutil 03:57:24 INFO - Running setup.py install for psutil 03:57:24 INFO - building 'psutil._psutil_linux' extension 03:57:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:57:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:57:24 INFO - building 'psutil._psutil_posix' extension 03:57:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:57:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:57:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:57:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:57:24 INFO - Successfully installed psutil 03:57:24 INFO - Cleaning up... 03:57:24 INFO - Return code: 0 03:57:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:24 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 0x7fa2bde5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2450350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24df1c0>, '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 0x24e00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e0550>, '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': 'df17445c3590ff7897617a0e00000225-1467542753.676176-570352329', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:57:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:57:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:57:24 INFO - Using env: {'DISPLAY': ':0', 03:57:24 INFO - 'HOME': '/home/cltbld', 03:57:24 INFO - 'LANG': 'en_US.UTF-8', 03:57:24 INFO - 'LANGUAGE': 'en_US:en', 03:57:24 INFO - 'LOGNAME': 'cltbld', 03:57:24 INFO - 'MAIL': '/var/mail/cltbld', 03:57:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:24 INFO - 'MOZ_NO_REMOTE': '1', 03:57:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:24 INFO - 'NO_EM_RESTART': '1', 03:57:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:24 INFO - 'PWD': '/builds/slave/test', 03:57:24 INFO - 'SHELL': '/bin/bash', 03:57:24 INFO - 'SHLVL': '1', 03:57:24 INFO - 'TERM': 'linux', 03:57:24 INFO - 'TMOUT': '86400', 03:57:24 INFO - 'USER': 'cltbld', 03:57:24 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467542753.676176-570352329', 03:57:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:24 INFO - '_': '/tools/buildbot/bin/python'} 03:57:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:57:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:57:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:57:27 INFO - Installing collected packages: mozsystemmonitor 03:57:27 INFO - Running setup.py install for mozsystemmonitor 03:57:27 INFO - Successfully installed mozsystemmonitor 03:57:27 INFO - Cleaning up... 03:57:27 INFO - Return code: 0 03:57:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:57:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:27 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 0x7fa2bde5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2450350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24df1c0>, '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 0x24e00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e0550>, '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': 'df17445c3590ff7897617a0e00000225-1467542753.676176-570352329', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:57:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:57:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:57:27 INFO - Using env: {'DISPLAY': ':0', 03:57:27 INFO - 'HOME': '/home/cltbld', 03:57:27 INFO - 'LANG': 'en_US.UTF-8', 03:57:27 INFO - 'LANGUAGE': 'en_US:en', 03:57:27 INFO - 'LOGNAME': 'cltbld', 03:57:27 INFO - 'MAIL': '/var/mail/cltbld', 03:57:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:27 INFO - 'MOZ_NO_REMOTE': '1', 03:57:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:27 INFO - 'NO_EM_RESTART': '1', 03:57:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:27 INFO - 'PWD': '/builds/slave/test', 03:57:27 INFO - 'SHELL': '/bin/bash', 03:57:27 INFO - 'SHLVL': '1', 03:57:27 INFO - 'TERM': 'linux', 03:57:27 INFO - 'TMOUT': '86400', 03:57:27 INFO - 'USER': 'cltbld', 03:57:27 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467542753.676176-570352329', 03:57:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:27 INFO - '_': '/tools/buildbot/bin/python'} 03:57:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:27 INFO - Downloading/unpacking jsonschema==2.5.1 03:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:57:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:29 INFO - Downloading functools32-3.2.3-2.tar.gz 03:57:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:57:29 INFO - warning: no files found matching '*.txt' 03:57:29 INFO - no previously-included directories found matching 'build' 03:57:29 INFO - no previously-included directories found matching 'dist' 03:57:29 INFO - no previously-included directories found matching '.git*' 03:57:29 INFO - Installing collected packages: jsonschema, functools32 03:57:29 INFO - Running setup.py install for functools32 03:57:29 INFO - warning: no files found matching '*.txt' 03:57:29 INFO - no previously-included directories found matching 'build' 03:57:29 INFO - no previously-included directories found matching 'dist' 03:57:29 INFO - no previously-included directories found matching '.git*' 03:57:29 INFO - Successfully installed jsonschema functools32 03:57:29 INFO - Cleaning up... 03:57:29 INFO - Return code: 0 03:57:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:29 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 0x7fa2bde5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2450350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24df1c0>, '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 0x24e00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e0550>, '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': 'df17445c3590ff7897617a0e00000225-1467542753.676176-570352329', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:57:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:57:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:57:29 INFO - Using env: {'DISPLAY': ':0', 03:57:29 INFO - 'HOME': '/home/cltbld', 03:57:29 INFO - 'LANG': 'en_US.UTF-8', 03:57:29 INFO - 'LANGUAGE': 'en_US:en', 03:57:29 INFO - 'LOGNAME': 'cltbld', 03:57:29 INFO - 'MAIL': '/var/mail/cltbld', 03:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:29 INFO - 'MOZ_NO_REMOTE': '1', 03:57:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:29 INFO - 'NO_EM_RESTART': '1', 03:57:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:29 INFO - 'PWD': '/builds/slave/test', 03:57:29 INFO - 'SHELL': '/bin/bash', 03:57:29 INFO - 'SHLVL': '1', 03:57:29 INFO - 'TERM': 'linux', 03:57:29 INFO - 'TMOUT': '86400', 03:57:29 INFO - 'USER': 'cltbld', 03:57:29 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467542753.676176-570352329', 03:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:29 INFO - '_': '/tools/buildbot/bin/python'} 03:57:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:29 INFO - Downloading/unpacking blobuploader==1.2.4 03:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:31 INFO - Downloading blobuploader-1.2.4.tar.gz 03:57:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:57:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:57:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:32 INFO - Downloading docopt-0.6.1.tar.gz 03:57:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:57:32 INFO - Installing collected packages: blobuploader, requests, docopt 03:57:32 INFO - Running setup.py install for blobuploader 03:57:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:57:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:57:32 INFO - Running setup.py install for requests 03:57:33 INFO - Running setup.py install for docopt 03:57:33 INFO - Successfully installed blobuploader requests docopt 03:57:33 INFO - Cleaning up... 03:57:33 INFO - Return code: 0 03:57:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:57:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:33 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 0x7fa2bde5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2450350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24df1c0>, '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 0x24e00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e0550>, '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': 'df17445c3590ff7897617a0e00000225-1467542753.676176-570352329', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:57:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:57:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:57:33 INFO - Using env: {'DISPLAY': ':0', 03:57:33 INFO - 'HOME': '/home/cltbld', 03:57:33 INFO - 'LANG': 'en_US.UTF-8', 03:57:33 INFO - 'LANGUAGE': 'en_US:en', 03:57:33 INFO - 'LOGNAME': 'cltbld', 03:57:33 INFO - 'MAIL': '/var/mail/cltbld', 03:57:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:33 INFO - 'MOZ_NO_REMOTE': '1', 03:57:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:33 INFO - 'NO_EM_RESTART': '1', 03:57:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:33 INFO - 'PWD': '/builds/slave/test', 03:57:33 INFO - 'SHELL': '/bin/bash', 03:57:33 INFO - 'SHLVL': '1', 03:57:33 INFO - 'TERM': 'linux', 03:57:33 INFO - 'TMOUT': '86400', 03:57:33 INFO - 'USER': 'cltbld', 03:57:33 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467542753.676176-570352329', 03:57:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:33 INFO - '_': '/tools/buildbot/bin/python'} 03:57:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:57:33 INFO - Running setup.py (path:/tmp/pip-r6HE32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:57:33 INFO - Running setup.py (path:/tmp/pip-c4_jln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:57:33 INFO - Running setup.py (path:/tmp/pip-su9owc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:57:33 INFO - Running setup.py (path:/tmp/pip-EB3xAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:57:33 INFO - Running setup.py (path:/tmp/pip-3CvT7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:57:33 INFO - Running setup.py (path:/tmp/pip-EfmvZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:57:33 INFO - Running setup.py (path:/tmp/pip-3FGb5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:57:34 INFO - Running setup.py (path:/tmp/pip-6mng6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:57:34 INFO - Running setup.py (path:/tmp/pip-_KcDN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:57:34 INFO - Running setup.py (path:/tmp/pip-7asm6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:57:34 INFO - Running setup.py (path:/tmp/pip-z1hRoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:57:34 INFO - Running setup.py (path:/tmp/pip-zYNik3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:57:34 INFO - Running setup.py (path:/tmp/pip-yenDow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:57:34 INFO - Running setup.py (path:/tmp/pip-sBLLbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:57:34 INFO - Running setup.py (path:/tmp/pip-eg5gXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:57:34 INFO - Running setup.py (path:/tmp/pip-wmQi8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:57:34 INFO - Running setup.py (path:/tmp/pip-_a2jeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:57:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:57:34 INFO - Running setup.py install for manifestparser 03:57:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:57:34 INFO - Running setup.py install for mozcrash 03:57:34 INFO - Running setup.py install for mozdebug 03:57:35 INFO - Running setup.py install for mozdevice 03:57:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:57:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:57:35 INFO - Running setup.py install for mozfile 03:57:35 INFO - Running setup.py install for mozhttpd 03:57:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:57:35 INFO - Running setup.py install for mozinfo 03:57:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:57:35 INFO - Running setup.py install for mozInstall 03:57:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:57:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:57:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:57:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:57:35 INFO - Running setup.py install for mozleak 03:57:35 INFO - Running setup.py install for mozlog 03:57:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:57:35 INFO - Running setup.py install for moznetwork 03:57:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:57:35 INFO - Running setup.py install for mozprocess 03:57:35 INFO - Running setup.py install for mozprofile 03:57:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:57:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:57:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:57:36 INFO - Running setup.py install for mozrunner 03:57:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:57:36 INFO - Running setup.py install for mozscreenshot 03:57:36 INFO - Running setup.py install for moztest 03:57:36 INFO - Running setup.py install for mozversion 03:57:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:57:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:57:36 INFO - Cleaning up... 03:57:36 INFO - Return code: 0 03:57:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:57: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')]} 03:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57: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')]} 03:57:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:36 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 0x7fa2bde5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2450350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24df1c0>, '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 0x24e00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e0550>, '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': 'df17445c3590ff7897617a0e00000225-1467542753.676176-570352329', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:57:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:57:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:57:36 INFO - Using env: {'DISPLAY': ':0', 03:57:36 INFO - 'HOME': '/home/cltbld', 03:57:36 INFO - 'LANG': 'en_US.UTF-8', 03:57:36 INFO - 'LANGUAGE': 'en_US:en', 03:57:36 INFO - 'LOGNAME': 'cltbld', 03:57:36 INFO - 'MAIL': '/var/mail/cltbld', 03:57:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:36 INFO - 'MOZ_NO_REMOTE': '1', 03:57:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:36 INFO - 'NO_EM_RESTART': '1', 03:57:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:36 INFO - 'PWD': '/builds/slave/test', 03:57:36 INFO - 'SHELL': '/bin/bash', 03:57:36 INFO - 'SHLVL': '1', 03:57:36 INFO - 'TERM': 'linux', 03:57:36 INFO - 'TMOUT': '86400', 03:57:36 INFO - 'USER': 'cltbld', 03:57:36 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467542753.676176-570352329', 03:57:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:36 INFO - '_': '/tools/buildbot/bin/python'} 03:57:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:57:36 INFO - Running setup.py (path:/tmp/pip-Nkf_b7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:57:36 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:57:36 INFO - Running setup.py (path:/tmp/pip-KbDYM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:57:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:57:36 INFO - Running setup.py (path:/tmp/pip-INr96_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:57:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:57:36 INFO - Running setup.py (path:/tmp/pip-4RETTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:57:37 INFO - Running setup.py (path:/tmp/pip-LQ7CHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:57:37 INFO - Running setup.py (path:/tmp/pip-YEFA9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:57:37 INFO - Running setup.py (path:/tmp/pip-LxCkSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:57:37 INFO - Running setup.py (path:/tmp/pip-wgBPI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:57:37 INFO - Running setup.py (path:/tmp/pip-DjPbis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:57:37 INFO - Running setup.py (path:/tmp/pip-tcn4pw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:57:37 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)) 03:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:57:37 INFO - Running setup.py (path:/tmp/pip-_tQtYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:57:37 INFO - Running setup.py (path:/tmp/pip-Ynullw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:57:37 INFO - Running setup.py (path:/tmp/pip-VaZEF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:57:37 INFO - Running setup.py (path:/tmp/pip-snuuiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:57:37 INFO - Running setup.py (path:/tmp/pip-hIeXHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:57:37 INFO - Running setup.py (path:/tmp/pip-ICSpyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:57:37 INFO - Running setup.py (path:/tmp/pip-bFwLql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:57:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:39 INFO - Downloading blessings-1.6.tar.gz 03:57:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:57:39 INFO - Installing collected packages: blessings 03:57:39 INFO - Running setup.py install for blessings 03:57:40 INFO - Successfully installed blessings 03:57:40 INFO - Cleaning up... 03:57:40 INFO - Return code: 0 03:57:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:57:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:57:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:57:40 INFO - Reading from file tmpfile_stdout 03:57:40 INFO - Current package versions: 03:57:40 INFO - argparse == 1.2.1 03:57:40 INFO - blessings == 1.6 03:57:40 INFO - blobuploader == 1.2.4 03:57:40 INFO - docopt == 0.6.1 03:57:40 INFO - functools32 == 3.2.3-2 03:57:40 INFO - jsonschema == 2.5.1 03:57:40 INFO - manifestparser == 1.1 03:57:40 INFO - mozInstall == 1.12 03:57:40 INFO - mozcrash == 0.17 03:57:40 INFO - mozdebug == 0.1 03:57:40 INFO - mozdevice == 0.48 03:57:40 INFO - mozfile == 1.2 03:57:40 INFO - mozhttpd == 0.7 03:57:40 INFO - mozinfo == 0.9 03:57:40 INFO - mozleak == 0.1 03:57:40 INFO - mozlog == 3.2 03:57:40 INFO - moznetwork == 0.27 03:57:40 INFO - mozprocess == 0.22 03:57:40 INFO - mozprofile == 0.28 03:57:40 INFO - mozrunner == 6.11 03:57:40 INFO - mozscreenshot == 0.1 03:57:40 INFO - mozsystemmonitor == 0.3 03:57:40 INFO - moztest == 0.7 03:57:40 INFO - mozversion == 1.4 03:57:40 INFO - psutil == 3.1.1 03:57:40 INFO - requests == 1.2.3 03:57:40 INFO - wsgiref == 0.1.2 03:57:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:40 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 0x7fa2bde5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2450350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24df1c0>, '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 0x24e00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e0550>, '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': 'df17445c3590ff7897617a0e00000225-1467542753.676176-570352329', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:57:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:57:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:57:40 INFO - Using env: {'DISPLAY': ':0', 03:57:40 INFO - 'HOME': '/home/cltbld', 03:57:40 INFO - 'LANG': 'en_US.UTF-8', 03:57:40 INFO - 'LANGUAGE': 'en_US:en', 03:57:40 INFO - 'LOGNAME': 'cltbld', 03:57:40 INFO - 'MAIL': '/var/mail/cltbld', 03:57:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:40 INFO - 'MOZ_NO_REMOTE': '1', 03:57:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:40 INFO - 'NO_EM_RESTART': '1', 03:57:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:40 INFO - 'PWD': '/builds/slave/test', 03:57:40 INFO - 'SHELL': '/bin/bash', 03:57:40 INFO - 'SHLVL': '1', 03:57:40 INFO - 'TERM': 'linux', 03:57:40 INFO - 'TMOUT': '86400', 03:57:40 INFO - 'USER': 'cltbld', 03:57:40 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467542753.676176-570352329', 03:57:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:40 INFO - '_': '/tools/buildbot/bin/python'} 03:57:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:57:40 INFO - Cleaning up... 03:57:40 INFO - Return code: 0 03:57:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2bde5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2450350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24df1c0>, '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 0x24e00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e0550>, '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': 'df17445c3590ff7897617a0e00000225-1467542753.676176-570352329', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:57:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:57:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:57:40 INFO - Using env: {'DISPLAY': ':0', 03:57:40 INFO - 'HOME': '/home/cltbld', 03:57:40 INFO - 'LANG': 'en_US.UTF-8', 03:57:40 INFO - 'LANGUAGE': 'en_US:en', 03:57:40 INFO - 'LOGNAME': 'cltbld', 03:57:40 INFO - 'MAIL': '/var/mail/cltbld', 03:57:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:40 INFO - 'MOZ_NO_REMOTE': '1', 03:57:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:40 INFO - 'NO_EM_RESTART': '1', 03:57:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:40 INFO - 'PWD': '/builds/slave/test', 03:57:40 INFO - 'SHELL': '/bin/bash', 03:57:40 INFO - 'SHLVL': '1', 03:57:40 INFO - 'TERM': 'linux', 03:57:40 INFO - 'TMOUT': '86400', 03:57:40 INFO - 'USER': 'cltbld', 03:57:40 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467542753.676176-570352329', 03:57:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:40 INFO - '_': '/tools/buildbot/bin/python'} 03:57:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:57:40 INFO - Cleaning up... 03:57:40 INFO - Return code: 0 03:57:40 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2bde5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2450350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24df1c0>, '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 0x24e00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e0550>, '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': 'df17445c3590ff7897617a0e00000225-1467542753.676176-570352329', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:57:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:57:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:57:40 INFO - Using env: {'DISPLAY': ':0', 03:57:40 INFO - 'HOME': '/home/cltbld', 03:57:40 INFO - 'LANG': 'en_US.UTF-8', 03:57:40 INFO - 'LANGUAGE': 'en_US:en', 03:57:40 INFO - 'LOGNAME': 'cltbld', 03:57:40 INFO - 'MAIL': '/var/mail/cltbld', 03:57:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:40 INFO - 'MOZ_NO_REMOTE': '1', 03:57:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:40 INFO - 'NO_EM_RESTART': '1', 03:57:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:40 INFO - 'PWD': '/builds/slave/test', 03:57:40 INFO - 'SHELL': '/bin/bash', 03:57:40 INFO - 'SHLVL': '1', 03:57:40 INFO - 'TERM': 'linux', 03:57:40 INFO - 'TMOUT': '86400', 03:57:40 INFO - 'USER': 'cltbld', 03:57:40 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467542753.676176-570352329', 03:57:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:40 INFO - '_': '/tools/buildbot/bin/python'} 03:57:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:40 INFO - Downloading/unpacking flake8 03:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:42 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:57:42 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:57:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:43 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:57:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:57:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:57:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:57:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:57:43 INFO - no previously-included directories found matching 'docs/_build' 03:57:43 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:57:43 INFO - Running setup.py install for pep8 03:57:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:57:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:57:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:57:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:57:43 INFO - no previously-included directories found matching 'docs/_build' 03:57:43 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:57:43 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:57:43 INFO - Cleaning up... 03:57:43 INFO - Return code: 0 03:57:43 INFO - Running post-action listener: _resource_record_post_action 03:57:43 INFO - Running post-action listener: _start_resource_monitoring 03:57:43 INFO - Starting resource monitoring. 03:57:43 INFO - ##### 03:57:43 INFO - ##### Finished create-virtualenv step (success) 03:57:43 INFO - ##### 03:57:43 INFO - ##### 03:57:43 INFO - ##### Running install step. 03:57:43 INFO - ##### 03:57:43 INFO - Running pre-action listener: _resource_record_pre_action 03:57:43 INFO - Running main action method: install 03:57:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:57:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:57:44 INFO - Reading from file tmpfile_stdout 03:57:44 INFO - Detecting whether we're running mozinstall >=1.0... 03:57:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:57:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:57:44 INFO - Reading from file tmpfile_stdout 03:57:44 INFO - Output received: 03:57:44 INFO - Usage: mozinstall [options] installer 03:57:44 INFO - Options: 03:57:44 INFO - -h, --help show this help message and exit 03:57:44 INFO - -d DEST, --destination=DEST 03:57:44 INFO - Directory to install application into. [default: 03:57:44 INFO - "/builds/slave/test"] 03:57:44 INFO - --app=APP Application being installed. [default: firefox] 03:57:44 INFO - mkdir: /builds/slave/test/build/application 03:57:44 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'] 03:57:44 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 03:58:00 INFO - Reading from file tmpfile_stdout 03:58:00 INFO - Output received: 03:58:00 INFO - /builds/slave/test/build/application/firefox/firefox 03:58:00 INFO - Running post-action listener: _resource_record_post_action 03:58:00 INFO - ##### 03:58:00 INFO - ##### Finished install step (success) 03:58:00 INFO - ##### 03:58:00 INFO - ##### 03:58:00 INFO - ##### Running run-tests step. 03:58:00 INFO - ##### 03:58:00 INFO - Running pre-action listener: _resource_record_pre_action 03:58:00 INFO - Running main action method: run_tests 03:58:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:58:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:58:00 INFO - Python 2.7.3 03:58:00 INFO - Return code: 0 03:58:00 INFO - grabbing minidump binary from tooltool 03:58: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')]} 03:58:00 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 0x24df1c0>, '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 0x24e00c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e0550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:58:00 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:58:00 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:58:00 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:58:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:58:00 INFO - Return code: 0 03:58:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:58:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:58:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:58:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:58:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:58:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:58:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:58:01 INFO - Return code: 0 03:58:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cGYNYlCVR4qILWx_V2WL6A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:58:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cGYNYlCVR4qILWx_V2WL6A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:58:01 INFO - Using env: {'DISPLAY': ':0', 03:58:01 INFO - 'HOME': '/home/cltbld', 03:58:01 INFO - 'LANG': 'en_US.UTF-8', 03:58:01 INFO - 'LANGUAGE': 'en_US:en', 03:58:01 INFO - 'LOGNAME': 'cltbld', 03:58:01 INFO - 'MAIL': '/var/mail/cltbld', 03:58:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:58:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:58:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:01 INFO - 'MOZ_NO_REMOTE': '1', 03:58:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:58:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:01 INFO - 'NO_EM_RESTART': '1', 03:58:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:01 INFO - 'PWD': '/builds/slave/test', 03:58:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:58:01 INFO - 'SHELL': '/bin/bash', 03:58:01 INFO - 'SHLVL': '1', 03:58:01 INFO - 'TERM': 'linux', 03:58:01 INFO - 'TMOUT': '86400', 03:58:01 INFO - 'USER': 'cltbld', 03:58:01 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467542753.676176-570352329', 03:58:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:01 INFO - '_': '/tools/buildbot/bin/python'} 03:58:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cGYNYlCVR4qILWx_V2WL6A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:58:01 INFO - mozversion application_buildid: 20160703010322 03:58:01 INFO - mozversion application_changeset: 49b4519a8d2e21e42649c9317e1d687af949bffd 03:58:01 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:58:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:58:01 INFO - mozversion application_name: Firefox 03:58:01 INFO - mozversion application_remotingname: firefox-dev 03:58:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:58:01 INFO - mozversion application_vendor: Mozilla 03:58:01 INFO - mozversion application_version: 49.0a2 03:58:01 INFO - mozversion platform_buildid: 20160703010322 03:58:01 INFO - mozversion platform_changeset: 49b4519a8d2e21e42649c9317e1d687af949bffd 03:58:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:58:01 INFO - mozversion platform_version: 49.0a2 03:58:01 INFO - using testdate: 1467543481 03:58:01 INFO - actual date: 1467543481 03:58:01 INFO - starting webserver on 'localhost:60326' 03:58:01 INFO - SUITE-START | Running 2 tests 03:58:01 INFO - TEST-START | dromaeo_css 03:58:01 INFO - operating with platform_type : linux_ 03:58:01 INFO - Initialising browser for dromaeo_css test... 03:58:01 INFO - TEST-INFO | started process 21639 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYR3MR8/profile http://localhost:60326/getInfo.html) 03:58:06 INFO - PROCESS | 21639 | __metrics Screen width/height:1600/1200 03:58:06 INFO - PROCESS | 21639 | colorDepth:24 03:58:06 INFO - PROCESS | 21639 | Browser inner width/height: 1024/697 03:58:06 INFO - PROCESS | 21639 | __metrics 03:58:07 ERROR - PROCESS | 21639 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:58:08 INFO - TEST-INFO | 21639: exit 0 03:58:08 INFO - Browser initialized. 03:58:08 INFO - Running cycle 1/1 for dromaeo_css test... 03:58:08 INFO - TEST-INFO | started process 21730 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYR3MR8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:58:20 INFO - PROCESS | 21730 | RSS: Main: 149528576 03:58:20 INFO - PROCESS | 21730 | 03:59:11 INFO - PROCESS | 21730 | 1467543551431 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:01:19 INFO - PROCESS | 21730 | Cycle 1(1): loaded http://localhost:60326/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60326/tests/dromaeo/cssquery-ext.html) 04:01:20 INFO - PROCESS | 21730 | RSS: Main: 256278528 04:01:20 INFO - PROCESS | 21730 | 04:04:23 INFO - PROCESS | 21730 | Cycle 1(1): loaded http://localhost:60326/tests/dromaeo/cssquery-ext.html (next: http://localhost:60326/tests/dromaeo/cssquery-jquery.html) 04:04:23 INFO - PROCESS | 21730 | RSS: Main: 234708992 04:04:23 INFO - PROCESS | 21730 | 04:07:25 INFO - PROCESS | 21730 | Cycle 1(1): loaded http://localhost:60326/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60326/tests/dromaeo/cssquery-mootools.html) 04:07:26 INFO - PROCESS | 21730 | RSS: Main: 229376000 04:07:26 INFO - PROCESS | 21730 | 04:10:28 INFO - PROCESS | 21730 | Cycle 1(1): loaded http://localhost:60326/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60326/tests/dromaeo/cssquery-prototype.html) 04:10:28 INFO - PROCESS | 21730 | RSS: Main: 221097984 04:10:28 INFO - PROCESS | 21730 | 04:13:31 INFO - PROCESS | 21730 | Cycle 1(1): loaded http://localhost:60326/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60326/tests/dromaeo/cssquery-yui.html) 04:13:31 INFO - PROCESS | 21730 | RSS: Main: 198860800 04:13:31 INFO - PROCESS | 21730 | 04:16:34 INFO - PROCESS | 21730 | Cycle 1(1): loaded http://localhost:60326/tests/dromaeo/cssquery-yui.html (next: http://localhost:60326/tests/dromaeo/cssquery-dojo.html) 04:16:34 INFO - PROCESS | 21730 | RSS: Main: 261722112 04:16:34 INFO - PROCESS | 21730 | 04:16:34 INFO - PROCESS | 21730 | __start_tp_report 04:16:34 INFO - PROCESS | 21730 | _x_x_mozilla_page_load 04:16:34 INFO - PROCESS | 21730 | _x_x_mozilla_page_load_details 04:16:34 INFO - PROCESS | 21730 | |i|pagename|runs| 04:16:34 INFO - PROCESS | 21730 | |0;dojo.html;3341.8329083545823;3348.1629592601857;3375.898723038308;3407.6421975692538;3426.5374174486437;5598.664080155194;5684.602077854546;5686.20393144959;5687.345955215152;5687.345955215152;5571.4428557144265;5592.6085174037835;5610.438956104398;5615.073512870382;5619.634723742954;4917.4344950330815;5010.649254552182;5056.898862022757;5068.062408454439;5099.796008159669;5059.291699162101;5094.949050509485;5096.821611243608;5100.15847385181;5101.84694459165;4999.575036121916;5054.292399064134;5084.923726144111;5085.491450854922;5093.617978651598;5115.565176959963;5144.6913185209005;5147.022065807522;5155.304033955405;5184.792608295664;4958.603311735053;4981.103401387749;4992.525710057539;5063.038022775698;5080.695158290514;5352.999999999961;5359.22291267764;5371.650842695251;5392.245085688007;5418.349798024262;5923.881522369528;5963.850903727398;5976.462118409364;5977.3723759005115;5979.820605381846;6006.429389208019;6009.429104235091;6060.606060606091;6075.787347442818;6081.422264884829;5684.204211410364;5686.886262274773;5706.543476521868;5725.4274572543245;5737.340205876294;5962.195103661037;6221.688915554295;6221.751129954751;6222.564420490522;6230.968845155836;5782.884342313214;5821.621594596338;5830.7959221427045;5946.1972633693895;5960.195373624592;5957.076653118774;5963.4931030862;5972.910406343908;6006.939930600638;6012.518998480111;5794.072948328248;5849.064149736022;5935.1987481690285;5942.821715348547;5951.940480595225;5870.178175055496;5951.226340575784;5954.642721436728;5968.104784282393;6006.339302676702;4564.041551274203;4569;4574.908501829945;4577.56513131252;4596.10375976688;4002.5397079335667;4056.492938382702;4064.349704047338;4094.590540945941;4100.036491424573;5760.423957604206;5772.94227057724;5792.594518383673;5795.1886735857015;5816.796412125555;6089.847753806191;6098.69506524672;6099.725512351954;6101;6133.325334213233;5513.228148059275;5611.242482264924;5627.409122042209;5654.46282603152;5689.118186681071;5185.040767458032;5207.609429292818;5212.40057393397;5216.26972223889;5217.113090774577;6223.097650840693;6249.468795152372;6273.686315684197;6278.46633036197;6278.686065696788;5393.244945707683;5842.883142337045;6005.459508644243;6042.728077236623;6105.236845394325;6255.844026658781;6296.716647750771;6296.968515157395;6300.2754683212015;6304.71628776697;5785.913211301918;5962.731677074456;5970.850728731816;5972.522198224218;6009.429104235091;5897.64614123154;5909.261342332208;5962.850928726816;5991.730372133177;5995.820125396245;5854.531637469077;5893.410658934073;5896.734646940984;5896.882062358814;5898.144769008555;5664.0654292043;5811.854703632443;5828.6211396259105;5865.706714664335;5881;5767.134929760569;5823.650580965155;5886.764529418775;5891.05743081105;5919.644821310735;5908.940910590839;5927.940720592911;6011.489023433057;6015.608985415934;6016.2479690038745;5637.57718171147;5706;5759.769609215585;5835.44563266489;5851.941480585139 04:16:34 INFO - PROCESS | 21730 | |1;ext.html;583.9941600583993;647.3397134922379;650.8958566629337;653.5588477777501;664.2759392262433;33606.66393336066;48504.272435913444;49412.50587494124;49420;49486.752566237206;48978;49493.752531237296;49545;49550;49565;8101.351891848638;9114.589843457044;9319.860202096974;11013.559457621686;11289.943550282238;10766.300190487633;11223.887761122365;11224.382658953795;11234.157438192127;11234.21360504765;11211.551537938472;11305;11307.321560706385;11310.660680179608;11312.943435282812;8156.429049966505;10944;11190.608328708537;11200.103991680646;11521.711957201052;11054.281471704313;11138.443077846156;11139.387333696643;11151.107911367153;11152.330860148417;46473.53526464726;46776.76611616954;46963.765181173876;46969.530304696855;47039.76480117612;3636.2182130841998;3641.417373220272;3662.359087159763;3744.569374521938;3841.9807900960595;35230;35391.4691279631;35628.287434251426;35829.10427239314;35895;4677.602403795681;4743.383360163191;4826.372571565674;4832.395950506187;4859.198232291667;387677;391182;393098;394173;394899;39210.60789392127;39907.60092399097;69763.65118174478;70455;70475;42355.57644423578;42406.36390454145;42576;42617.57382426198;42632.14735705269;14963.326650300764;16551.08969006716;16786.49640510762;16790.32838686439;16811.243494042796;12947.611571652866;13309.201447913156;13340.332983350987;13738.313084345742;13973.301334933212;9372.39079459833;9378.85931711025;9379.765505862271;9435.292353073546;9459.810803783887;3563.7505374624047;3570.303790760777;3644.7084233261276;3669.3028324618235;3670.853165873335;1027.845823126537;1117.2067831839322;1133.8582677165355;1160.3907948327196;1220.9023278137727;34699.826500867835;34748.47877281843;34926;35032.47451288233;35086.64913350885;1192;1222.370479203211;1239.8450193725785;1306.7321199154342;1325.2578556008473;17961;18146.09269536518;18173.273069077088;18191;18219.635607288044;658856;664779;667459;667485;669379;65005.67497162484;65601.39192344372;65685.67157164279;65757.34242657512;65930.34069659242;1364.5224171539883;1432.4914655297428;1466.2155746675692;1474.3660226102663;1498.3257534109694;34350.48474272838;34678.30643387169;35498.29003419865;35691.64308356987;35944.820275898455;55707;55943.440565593824;56400;56425.153622694874;56427;441247;441961;442279;444933;446059;28428.57357139603;30610.540841886945;32102.839485802422;32222.35555288928;33640.663593364734;50999.74500127476;53500;53943;54109;54622;44109.33835992398;44419.33370999373;44755.776221118685;45260;45498;43857.56142438662;44264;44443;44912.55087449084;45009.32486012647;43773.78113109414;44744.32883506685;44795;44972.10055798931;45110;36989;39011.80494097511;39369.40945885871;39448.605513944494;39953.20093598054;29145;29192.27019324534;29443.558346625246;29628.81736937363;29728.405431891675 04:16:34 INFO - PROCESS | 21730 | |2;jquery.html;425.17516018923277;425.80413010015394;435.97912823901896;440.9955900440997;441.27850963674393;18625.53436164095;19460.12429440673;20371.796282037194;20848;21019.57960840782;19630.607387852233;19634.70547941782;19917.10373033213;20093.09581068852;20161.899190504064;5722.914156287648;5921.911171332434;5962.8807423851495;5969.5821292509545;5973.940260597382;5662.348829884575;5883.470487656132;5937.37657545958;5952.940470595304;5972.104184372357;5991.670458124801;5995.790147344844;6003.969980150093;6012.3687012863675;6023.36754640763;6032.366601506845;6389.6805159741825;6569.244536878273;6597.208334999783;6601.603903765766;5530.170474428827;5780.913286300709;5791.478766910956;5808.041673123929;5812.534997200256;14468.348924298327;14475.638109047359;14530.128192308495;14603.48887788933;14659;2396.616541353375;2420.1529464687396;2445.6209287560455;2520.420303330244;2601.713811480736;9989.300748947577;10187.286889917708;10629.787404251872;10823.24237303389;11176.21766476347;1858.9163487643089;1873.2694249242807;1903.562180698447;1924.6439408709434;2015.2946468735972;74761;76417.61791191009;77292.22707772907;81666;85387.5730621349;11324.886751132548;11644.301341919512;11728.120390970711;11874.1094417919;11979.401029948467;16447.506574802774;16491.34034638625;16633.417830375878;16740;16786.74819877703;8420.410571260076;8647.783805404915;8682.56888071341;8776.956115219511;8944.597493112826;8982;9010.63957441695;9070.909290907139;9072.50101244438;9170.770730731785;4964.081644895634;4991.359204551667;5017.523335283142;5156.9742151289;5158.432572417031;1973.2205778717325;2011.7911930470875;2070.109852763296;2091.801278878504;2142.507223338641;471.8324994626927;809.0614886731481;995.5569771451779;1036.683811437519;1151.758130792543;11506.76986460283;11734.767849375692;11846.348450835287;12420.937895310646;12621.558245461365;489.5789620926001;494.04402481198997;505.36576596371316;507.031569701875;519.706365903271;6607.108040414579;6668.966655166693;6677.666116694146;6712.932870671329;6717.596944183365;399011;399334;402085;541423;570059;103916;109259.45370273097;109264;109543;110532.4473377628;1089.8746644135867;1094.7865166292656;1135.6593022093505;1146.5356530605118;1152.4410660829492;13622.591322260349;16667.583310417336;17453.040082795567;17929.462116136016;17974.19116139803;41861.37207941822;43423.34864977091;44380.334294984954;44438.11123777571;45306.32040519461;57837.71081144567;59328.110078349724;59533.10700339585;60346;60520.39479605148;8600.182982616641;8749.387542871938;8811.65193576497;8943.272301947709;8956.193942545202;9348.439093654402;11871.525138994344;12267.447964841425;12298.569550066062;12528.436220370288;11072.889271107186;11074.889251107708;11171.608993685182;11175.72060698489;11293.71765705864;10941.726456838323;11048.944755276172;11051;11087.833682494931;11346.092312614806;11022.393768342497;11189.384583847966;11256.7748645025;11318.09455243595;11366.659000230007;8323.209295116954;8337.874931876147;8357.916420835714;8360.707375241838;8527.957360213408;10831.729206769895;11153.498092586015;11213.439328033728;11228.38243896561;11306.4912078955 04:16:34 INFO - PROCESS | 21730 | |3;mootools.html;1321.5837011341428;1436.8634979676926;1447.8841692664587;1483.2138966347832;1876.0807204469813;8847.33644976627;9207.033261507546;9247.630094796208;9486.33595648305;9500.904990950088;9188.632454701803;9395.577199026044;9396.48319342436;9400.529973501314;9408.20030297424;2471.7651823076826;2496.5131799299143;2497.5878979968284;2497.6628155199087;2499.1128149506844;2521.936951576207;2579.548578998677;2581.3288544978345;2582.948341033178;2583.8837252323597;2436.415260337524;2457.4839283750434;2518.3326418499114;2521.420073383114;2522.8738563071865;2455.017992802875;2466.087547607388;2473.8144639152138;2484.4782595654933;2504.0860086068637;2415.951680966371;2417.9516409671883;2440.780329770329;2443.15711079679;2462.347477918353;8967.730968070902;9199.862002069975;9233.445993240428;9292.628294868196;9297.209737172348;5452.836414907559;5571.9442805572235;5586.1062230043;5586.608937374385;5587.944120558824;3482.4253998090285;3517.437210046406;3546.8758593449365;3561.305545418644;3568.982155089234;1095.7205912492343;1102.399192440122;1174.2074099982563;1183.828344889986;1201.4593432955119;12832.679183020406;12993.545225917047;12998.610041698765;13004.804927925994;13007.804882926765;4855.854324370274;4864.975675121602;4895.388076490439;4907.975460122677;4977;9918;10018.899811001942;10076.49617519121;10078.596856125672;10102.040306170902;5496.038193316153;5499.092649712833;5502.284702988586;5502.339719233718;5503.724813759376;4575.382323386367;4850.151223535867;5035.395752509649;5212.087884620177;5223.817166399158;4073.348264277701;4079.286124928185;4096.1193343431305;4147.357159640261;4152.252594532953;1224.0758227538329;1230.7415442756942;1236.0358920042381;1236.8330275412884;1260.8565438754154;842.2251528593708;1028.9022542858415;1047.9056884880397;1075.8547596074586;1077.1490522487147;6338.461230795342;6419.775307864203;6432.935670643327;6444.7744328948265;6445.484361251089;505.75723652646934;520.6901893373437;521.7834598641597;526.5208660119273;685.5441131647498;4297.978510107492;4328.718633288826;4370.366296886934;4382.802773875183;4485.215087359699;11307.604233851776;11562.537498499965;11659.88340116588;11698.824517632242;11730.70673233159;11034.724131896766;11480.081593472501;11559.133065019989;11597.246178998337;11599.6520104397;8753.168448997336;8885.955570222237;8890.199882010651;8917.955410223038;8942.105789421135;6398.5201109916015;6587.571807832475;6629.204495460575;6685.064091027358;6693.364130407604;10278.280520363802;10548.789024219319;10555.63055293061;10659.307145035547;10728.302660327054;9618.038196180327;10755.623553175914;10835.837462437912;10875.619353322596;10889.455527223765;7718.3053525183;7949.244821741925;7950.681972721027;8077.27304542594;8087.595620219083;8075.717349892726;8242.670293188205;8258.628361723617;8504.277136443225;8618.181272779077;7553.660085296285;7665.923340766521;7727.6136193188995;7986.800329991796;8169.836603268021;8084.595770211348;8112.310453611273;8125.553094579618;8134.389920755849;8264.504129752235;7402.1857595665515;7461.888071679038;7508.774736757906;7509.4367922404945;7519.962400188183;5262.684238945675;5465.426130256425;5499.422560631237;5585.636933599303;5760.193572899713;5413.53984911287;5617.915731264116;5656.377798442086;5708.143778433268;5801.564882633735 04:16:34 INFO - PROCESS | 21730 | |4;prototype.html;351.0101513731278;359.31371081234846;361.56431500042453;362.9219717760681;365.82440428594276;5522.723863806808;5558.471945165208;5567.137093750465;5578.9163162552595;5582.855514619503;5461;5519;5523.475269849368;5532.723363831802;5542.861428464291;4195.671402371675;4281.571842815709;4301.741895486281;4321.243782338078;4331.938675024623;4277;4307.267764480031;4309.267424537836;4313.784310784464;4369.80335884886;4279.72181808183;4288.1423715256915;4299.247631664462;4317.244482215616;4324.74051556906;4173.4157217989505;4280.357946308048;4287.142571485715;4291.935620965688;4317.935230971522;3772.2832661794173;3790.7915064671433;3795.867144649924;3798;3812.3519001769764;5337.626366154371;5360.249565060894;5362.705051222181;5365.195220716884;5366.9463305366835;4802.567768900781;4979.551840334388;4980.452150263468;4990.725510096943;5005.449400565934;5715.0855863062125;5721.427857214287;5785.681787501686;5795.478406943395;5816.190395291091;4159.438475805758;4183.91632167355;4195;4202.327627579572;4239.6221228100685;6014.578979471439;6023.939760602381;6064.60580062299;6067.514598832127;6149.692515374258;4268.423762791983;4286.742795432284;4287.97856010718;4290.978545107255;4291.74249545022;4345.717528360647;4350.108227813291;4351.823169086584;4352.325389564622;4356.6514678825615;4768.690035147773;4928.334674818925;4949.381327334083;5001.124803159432;5019.268352418409;5757.193992840922;5797.913031304533;5863.941360586425;5871.442212989759;5925.170476133345;1463.4146341463286;1475.579459853958;1490.0538158269576;1492.6790739990954;1495.835458099608;909.1771946388529;913.9223166030829;920.9171174594319;974.1573538888811;978.3396207560011;4977.228529577921;4982.501749824988;4992.301077849104;4995.375578052744;5009.499050095034;5308.442613525524;5310.734463276898;5318.946810531923;5327.627066105335;5337.919931201035;5025.271335656309;5025.723585202849;5092.490750924878;5300.92048619271;5800.854978625483;3222.726068284222;3252.6259480160084;3255.9837200813845;3256.886008989721;3258.4297747894498;6075.969620151871;6292.9233352994315;6305.738852229572;6307.445484578753;6313.494920406357;5893.852653683693;6042.909356359658;6093.634381937098;6108.847278817976;6141.447269745744;5999.900084927776;6128.835521251037;6134.5277133488535;6151.569390142647;6177.505799536027;5861.443162899518;5957.302168881848;5970.31341395745;6032.426919442646;6033.909491357721;5884.293225116495;5904.9704751475965;5905.5570832186895;5916.911246331222;5923.170756094064;6081.411966939527;6146.692665366624;6161.353057928853;6167.136600875791;6204.317525072148;4106.876793696194;4233.751043442254;4247.723897946624;4271.893202669834;4278.379634952977;5929.229200203946;5991.430814072656;5996.400359964143;6000.519958403404;6003.429674180946;5816.3892791258;5857.502112320501;5860.560457965585;5894.410558944071;5900.232969713909;5639.182318563868;5778.739956701875;5815.912761308499;5816.970915145397;5831.912521312099;5695.515881150149;5710.685912274865;5715.571332150189;5727.198192253171;5761.654300741969;5645.266115405136;5876.529877609695;5887.970560147343;5893.734781934738;5990.716637604134;5708.686022268649;5769.711514424178;5829.59192856513;5836.533077353886;5858.443447872445 04:16:34 INFO - PROCESS | 21730 | |5;yui.html;758.1395116542723;798.9280964713174;835.6156168162645;871.5467956662532;889.875417441558;16330.591735206612;17192.914035429807;17194.82805171948;17219.225134868928;17234.82765172348;14750;14754.778678319833;14794.926025369858;14875.628109297273;14915.925420372883;708.7909066825273;835.9540225287607;852.3607294529103;864.723288547665;867.7657032601194;852.4799872078028;853.7353420439683;857.438377862501;858.4205661178679;858.7252079334615;906.8685040669098;914.0128661046087;914.3325372478095;916.1754421021068;916.7937214126835;740.774063910507;768.7271018788306;908.6819613135383;909.7179874238974;910.9089091090871;562.3982338897381;647.679398697643;665.9134312539339;666.6766618190173;667.5494041521953;15622.296996635065;15680.843191568052;15694.843051569453;15751.2124393781;15760.60598485047;14289.642758931006;14476.34856431463;14545;14596.124232545975;14679.119252844863;12139.635810925687;12645.367731613474;12658.936705316415;13006.284654344006;13170.27563484008;4623.74569398683;4627.421572303462;4632.698874573142;4694.319323698045;4713.622910167179;85761.57119214427;86407;86709.13290867137;87686.56156719239;87951.56024219838;12110.81833772494;12215.694607634703;12243;12259.387030648431;12561.811572826415;20198.29305974284;21260.78739212619;21405;21438.78561214399;21450.57098858014;8890.422122562013;8961.507117108491;8974.14745599167;9110;9166.587503562223;5066.847994560169;5071.061853557104;5213.322268105122;5279.1289437243195;5362.061639213122;3517.1734642359024;3601.369760291991;3605.94591081134;3609.9639003609627;3616.168281295264;695.3081683724727;702.1574111066639;742.866284068862;775.8525880082766;789.1161898673407;690.6374153569316;716.6631683108931;755.1353700013453;774.0169984120135;778.1479280188184;10388.480575971322;10554.050135487843;10749.892501075046;10898.291611045415;10932.344059356465;633.9207599050119;776.7786180938518;782.1669921533548;784.7135795434739;801.410962942237;5213.843584692389;5251.501107394792;5266.789328426897;5296.549793267538;5345.465453454701;79219.20780792234;79510.6024469874;79747.8037829433;86833.56583217044;127420;69536.6523167381;69696;72445.2755472449;83156.58421707853;105812;64653;91985;95244.52377738067;97031;98191.50904245433;9846.359986600848;10056.195504359488;10115.696529104138;10156.44139572301;10237.181025517792;51656.22515662193;52106;53678;54203.45796542142;54372.72813635907;67165;67653.3234667647;68020.31979680338;75745;79171;13223.735525289248;13478;13701.657458563615;14142.929285353508;14380.42478300898;15127.915482725044;15741.134237617041;15742.449014284903;15803.446879359168;16044.197790110215;10724.624638137628;14319.785203222169;14841.480548181195;14975.850241497446;15155.242237887842;14652.853471465149;14751.92624036916;14917.552473425814;15310;15746.370145194063;13142.737145257233;13151.079424440197;13189.472421103048;13321.86678133245;13747.656308592364;11901;12062.396880156133;12409.441575129322;12442.377881105727;12554.183978041397;11883.58407455735;12259.264444133381;12411;12466.626001219978;12785.48858045705 04:16:34 INFO - PROCESS | 21730 | __end_tp_report 04:16:34 INFO - PROCESS | 21730 | __start_cc_report 04:16:34 INFO - PROCESS | 21730 | _x_x_mozilla_cycle_collect,927 04:16:34 INFO - PROCESS | 21730 | __end_cc_report 04:16:34 INFO - PROCESS | 21730 | __startTimestamp1467544594313__endTimestamp 04:16:34 INFO - PROCESS | 21730 | 04:16:34 INFO - PROCESS | 21730 | ------- Summary: start ------- 04:16:34 INFO - PROCESS | 21730 | Number of tests: 6 04:16:34 INFO - PROCESS | 21730 | 04:16:34 INFO - PROCESS | 21730 | [#0] dojo.html Cycles:165 Average:5573.81 Median:5795.19 stddev:630.80 (10.9%) stddev-sans-first:607.95 04:16:34 INFO - PROCESS | 21730 | Values: 3341.8 3348.2 3375.9 3407.6 3426.5 5598.7 5684.6 5686.2 5687.3 5687.3 5571.4 5592.6 5610.4 5615.1 5619.6 4917.4 5010.6 5056.9 5068.1 5099.8 5059.3 5094.9 5096.8 5100.2 5101.8 4999.6 5054.3 5084.9 5085.5 5093.6 5115.6 5144.7 5147.0 5155.3 5184.8 4958.6 4981.1 4992.5 5063.0 5080.7 5353.0 5359.2 5371.7 5392.2 5418.3 5923.9 5963.9 5976.5 5977.4 5979.8 6006.4 6009.4 6060.6 6075.8 6081.4 5684.2 5686.9 5706.5 5725.4 5737.3 5962.2 6221.7 6221.8 6222.6 6231.0 5782.9 5821.6 5830.8 5946.2 5960.2 5957.1 5963.5 5972.9 6006.9 6012.5 5794.1 5849.1 5935.2 5942.8 5951.9 5870.2 5951.2 5954.6 5968.1 6006.3 4564.0 4569.0 4574.9 4577.6 4596.1 4002.5 4056.5 4064.3 4094.6 4100.0 5760.4 5772.9 5792.6 5795.2 5816.8 6089.8 6098.7 6099.7 6101.0 6133.3 5513.2 5611.2 5627.4 5654.5 5689.1 5185.0 5207.6 5212.4 5216.3 5217.1 6223.1 6249.5 6273.7 6278.5 6278.7 5393.2 5842.9 6005.5 6042.7 6105.2 6255.8 6296.7 6297.0 6300.3 6304.7 5785.9 5962.7 5970.9 5972.5 6009.4 5897.6 5909.3 5962.9 5991.7 5995.8 5854.5 5893.4 5896.7 5896.9 5898.1 5664.1 5811.9 5828.6 5865.7 5881.0 5767.1 5823.7 5886.8 5891.1 5919.6 5908.9 5927.9 6011.5 6015.6 6016.2 5637.6 5706.0 5759.8 5835.4 5851.9 04:16:34 INFO - PROCESS | 21730 | 04:16:34 INFO - PROCESS | 21730 | [#1] ext.html Cycles:180 Average:66292.73 Median:215196.30 stddev:137034.25 (63.7%) stddev-sans-first:137329.86 04:16:34 INFO - PROCESS | 21730 | Values: 584.0 647.3 650.9 653.6 664.3 33606.7 48504.3 49412.5 49420.0 49486.8 48978.0 49493.8 49545.0 49550.0 49565.0 8101.4 9114.6 9319.9 11013.6 11289.9 10766.3 11223.9 11224.4 11234.2 11234.2 11211.6 11305.0 11307.3 11310.7 11312.9 8156.4 10944.0 11190.6 11200.1 11521.7 11054.3 11138.4 11139.4 11151.1 11152.3 46473.5 46776.8 46963.8 46969.5 47039.8 3636.2 3641.4 3662.4 3744.6 3842.0 35230.0 35391.5 35628.3 35829.1 35895.0 4677.6 4743.4 4826.4 4832.4 4859.2 387677.0 391182.0 393098.0 394173.0 394899.0 39210.6 39907.6 69763.7 70455.0 70475.0 42355.6 42406.4 42576.0 42617.6 42632.1 14963.3 16551.1 16786.5 16790.3 16811.2 12947.6 13309.2 13340.3 13738.3 13973.3 9372.4 9378.9 9379.8 9435.3 9459.8 3563.8 3570.3 3644.7 3669.3 3670.9 1027.8 1117.2 1133.9 1160.4 1220.9 34699.8 34748.5 34926.0 35032.5 35086.6 1192.0 1222.4 1239.8 1306.7 1325.3 17961.0 18146.1 18173.3 18191.0 18219.6 658856.0 664779.0 667459.0 667485.0 669379.0 65005.7 65601.4 65685.7 65757.3 65930.3 1364.5 1432.5 1466.2 1474.4 1498.3 34350.5 34678.3 35498.3 35691.6 35944.8 55707.0 55943.4 56400.0 56425.2 56427.0 441247.0 441961.0 442279.0 444933.0 446059.0 28428.6 30610.5 32102.8 32222.4 33640.7 50999.7 53500.0 53943.0 54109.0 54622.0 44109.3 44419.3 44755.8 45260.0 45498.0 43857.6 44264.0 44443.0 44912.6 45009.3 43773.8 44744.3 44795.0 44972.1 45110.0 36989.0 39011.8 39369.4 39448.6 39953.2 29145.0 29192.3 29443.6 29628.8 29728.4 04:16:34 INFO - PROCESS | 21730 | 04:16:34 INFO - PROCESS | 21730 | [#2] jquery.html Cycles:180 Average:28274.79 Median:399172.50 stddev:77963.30 (19.5%) stddev-sans-first:78153.97 04:16:34 INFO - PROCESS | 21730 | Values: 425.2 425.8 436.0 441.0 441.3 18625.5 19460.1 20371.8 20848.0 21019.6 19630.6 19634.7 19917.1 20093.1 20161.9 5722.9 5921.9 5962.9 5969.6 5973.9 5662.3 5883.5 5937.4 5952.9 5972.1 5991.7 5995.8 6004.0 6012.4 6023.4 6032.4 6389.7 6569.2 6597.2 6601.6 5530.2 5780.9 5791.5 5808.0 5812.5 14468.3 14475.6 14530.1 14603.5 14659.0 2396.6 2420.2 2445.6 2520.4 2601.7 9989.3 10187.3 10629.8 10823.2 11176.2 1858.9 1873.3 1903.6 1924.6 2015.3 74761.0 76417.6 77292.2 81666.0 85387.6 11324.9 11644.3 11728.1 11874.1 11979.4 16447.5 16491.3 16633.4 16740.0 16786.7 8420.4 8647.8 8682.6 8777.0 8944.6 8982.0 9010.6 9070.9 9072.5 9170.8 4964.1 4991.4 5017.5 5157.0 5158.4 1973.2 2011.8 2070.1 2091.8 2142.5 471.8 809.1 995.6 1036.7 1151.8 11506.8 11734.8 11846.3 12420.9 12621.6 489.6 494.0 505.4 507.0 519.7 6607.1 6669.0 6677.7 6712.9 6717.6 399011.0 399334.0 402085.0 541423.0 570059.0 103916.0 109259.5 109264.0 109543.0 110532.4 1089.9 1094.8 1135.7 1146.5 1152.4 13622.6 16667.6 17453.0 17929.5 17974.2 41861.4 43423.3 44380.3 44438.1 45306.3 57837.7 59328.1 59533.1 60346.0 60520.4 8600.2 8749.4 8811.7 8943.3 8956.2 9348.4 11871.5 12267.4 12298.6 12528.4 11072.9 11074.9 11171.6 11175.7 11293.7 10941.7 11048.9 11051.0 11087.8 11346.1 11022.4 11189.4 11256.8 11318.1 11366.7 8323.2 8337.9 8357.9 8360.7 8528.0 10831.7 11153.5 11213.4 11228.4 11306.5 04:16:34 INFO - PROCESS | 21730 | 04:16:34 INFO - PROCESS | 21730 | [#3] mootools.html Cycles:180 Average:6074.87 Median:4880.18 stddev:3450.72 (70.7%) stddev-sans-first:3441.91 04:16:34 INFO - PROCESS | 21730 | Values: 1321.6 1436.9 1447.9 1483.2 1876.1 8847.3 9207.0 9247.6 9486.3 9500.9 9188.6 9395.6 9396.5 9400.5 9408.2 2471.8 2496.5 2497.6 2497.7 2499.1 2521.9 2579.5 2581.3 2582.9 2583.9 2436.4 2457.5 2518.3 2521.4 2522.9 2455.0 2466.1 2473.8 2484.5 2504.1 2416.0 2418.0 2440.8 2443.2 2462.3 8967.7 9199.9 9233.4 9292.6 9297.2 5452.8 5571.9 5586.1 5586.6 5587.9 3482.4 3517.4 3546.9 3561.3 3569.0 1095.7 1102.4 1174.2 1183.8 1201.5 12832.7 12993.5 12998.6 13004.8 13007.8 4855.9 4865.0 4895.4 4908.0 4977.0 9918.0 10018.9 10076.5 10078.6 10102.0 5496.0 5499.1 5502.3 5502.3 5503.7 4575.4 4850.2 5035.4 5212.1 5223.8 4073.3 4079.3 4096.1 4147.4 4152.3 1224.1 1230.7 1236.0 1236.8 1260.9 842.2 1028.9 1047.9 1075.9 1077.1 6338.5 6419.8 6432.9 6444.8 6445.5 505.8 520.7 521.8 526.5 685.5 4298.0 4328.7 4370.4 4382.8 4485.2 11307.6 11562.5 11659.9 11698.8 11730.7 11034.7 11480.1 11559.1 11597.2 11599.7 8753.2 8886.0 8890.2 8918.0 8942.1 6398.5 6587.6 6629.2 6685.1 6693.4 10278.3 10548.8 10555.6 10659.3 10728.3 9618.0 10755.6 10835.8 10875.6 10889.5 7718.3 7949.2 7950.7 8077.3 8087.6 8075.7 8242.7 8258.6 8504.3 8618.2 7553.7 7665.9 7727.6 7986.8 8169.8 8084.6 8112.3 8125.6 8134.4 8264.5 7402.2 7461.9 7508.8 7509.4 7520.0 5262.7 5465.4 5499.4 5585.6 5760.2 5413.5 5617.9 5656.4 5708.1 5801.6 04:16:34 INFO - PROCESS | 21730 | 04:16:34 INFO - PROCESS | 21730 | [#4] prototype.html Cycles:180 Average:4863.58 Median:5520.86 stddev:1429.49 (25.9%) stddev-sans-first:1392.79 04:16:34 INFO - PROCESS | 21730 | Values: 351.0 359.3 361.6 362.9 365.8 5522.7 5558.5 5567.1 5578.9 5582.9 5461.0 5519.0 5523.5 5532.7 5542.9 4195.7 4281.6 4301.7 4321.2 4331.9 4277.0 4307.3 4309.3 4313.8 4369.8 4279.7 4288.1 4299.2 4317.2 4324.7 4173.4 4280.4 4287.1 4291.9 4317.9 3772.3 3790.8 3795.9 3798.0 3812.4 5337.6 5360.2 5362.7 5365.2 5366.9 4802.6 4979.6 4980.5 4990.7 5005.4 5715.1 5721.4 5785.7 5795.5 5816.2 4159.4 4183.9 4195.0 4202.3 4239.6 6014.6 6023.9 6064.6 6067.5 6149.7 4268.4 4286.7 4288.0 4291.0 4291.7 4345.7 4350.1 4351.8 4352.3 4356.7 4768.7 4928.3 4949.4 5001.1 5019.3 5757.2 5797.9 5863.9 5871.4 5925.2 1463.4 1475.6 1490.1 1492.7 1495.8 909.2 913.9 920.9 974.2 978.3 4977.2 4982.5 4992.3 4995.4 5009.5 5308.4 5310.7 5318.9 5327.6 5337.9 5025.3 5025.7 5092.5 5300.9 5800.9 3222.7 3252.6 3256.0 3256.9 3258.4 6076.0 6292.9 6305.7 6307.4 6313.5 5893.9 6042.9 6093.6 6108.8 6141.4 5999.9 6128.8 6134.5 6151.6 6177.5 5861.4 5957.3 5970.3 6032.4 6033.9 5884.3 5905.0 5905.6 5916.9 5923.2 6081.4 6146.7 6161.4 6167.1 6204.3 4106.9 4233.8 4247.7 4271.9 4278.4 5929.2 5991.4 5996.4 6000.5 6003.4 5816.4 5857.5 5860.6 5894.4 5900.2 5639.2 5778.7 5815.9 5817.0 5831.9 5695.5 5710.7 5715.6 5727.2 5761.7 5645.3 5876.5 5888.0 5893.7 5990.7 5708.7 5769.7 5829.6 5836.5 5858.4 04:16:34 INFO - PROCESS | 21730 | 04:16:34 INFO - PROCESS | 21730 | [#5] yui.html Cycles:180 Average:20337.95 Median:4890.24 stddev:27671.80 (565.9%) stddev-sans-first:27710.37 04:16:34 INFO - PROCESS | 21730 | Values: 758.1 798.9 835.6 871.5 889.9 16330.6 17192.9 17194.8 17219.2 17234.8 14750.0 14754.8 14794.9 14875.6 14915.9 708.8 836.0 852.4 864.7 867.8 852.5 853.7 857.4 858.4 858.7 906.9 914.0 914.3 916.2 916.8 740.8 768.7 908.7 909.7 910.9 562.4 647.7 665.9 666.7 667.5 15622.3 15680.8 15694.8 15751.2 15760.6 14289.6 14476.3 14545.0 14596.1 14679.1 12139.6 12645.4 12658.9 13006.3 13170.3 4623.7 4627.4 4632.7 4694.3 4713.6 85761.6 86407.0 86709.1 87686.6 87951.6 12110.8 12215.7 12243.0 12259.4 12561.8 20198.3 21260.8 21405.0 21438.8 21450.6 8890.4 8961.5 8974.1 9110.0 9166.6 5066.8 5071.1 5213.3 5279.1 5362.1 3517.2 3601.4 3605.9 3610.0 3616.2 695.3 702.2 742.9 775.9 789.1 690.6 716.7 755.1 774.0 778.1 10388.5 10554.1 10749.9 10898.3 10932.3 633.9 776.8 782.2 784.7 801.4 5213.8 5251.5 5266.8 5296.5 5345.5 79219.2 79510.6 79747.8 86833.6 127420.0 69536.7 69696.0 72445.3 83156.6 105812.0 64653.0 91985.0 95244.5 97031.0 98191.5 9846.4 10056.2 10115.7 10156.4 10237.2 51656.2 52106.0 53678.0 54203.5 54372.7 67165.0 67653.3 68020.3 75745.0 79171.0 13223.7 13478.0 13701.7 14142.9 14380.4 15127.9 15741.1 15742.4 15803.4 16044.2 10724.6 14319.8 14841.5 14975.9 15155.2 14652.9 14751.9 14917.6 15310.0 15746.4 13142.7 13151.1 13189.5 13321.9 13747.7 11901.0 12062.4 12409.4 12442.4 12554.2 11883.6 12259.3 12411.0 12466.6 12785.5 04:16:34 INFO - PROCESS | 21730 | -------- Summary: end -------- 04:16:34 INFO - PROCESS | 21730 | 04:16:34 INFO - TEST-INFO | 21730: exit 0 04:16:34 INFO - TEST-OK | dromaeo_css | took 1113745ms 04:16:34 INFO - TEST-START | kraken 04:16:34 INFO - operating with platform_type : linux_ 04:16:34 INFO - Initialising browser for kraken test... 04:16:34 INFO - TEST-INFO | started process 21919 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr1TOQY/profile http://localhost:60326/getInfo.html) 04:16:39 INFO - PROCESS | 21919 | __metrics Screen width/height:1600/1200 04:16:39 INFO - PROCESS | 21919 | colorDepth:24 04:16:39 INFO - PROCESS | 21919 | Browser inner width/height: 1024/697 04:16:39 INFO - PROCESS | 21919 | __metrics 04:16:41 ERROR - PROCESS | 21919 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:16:42 INFO - TEST-INFO | 21919: exit 0 04:16:42 INFO - Browser initialized. 04:16:42 INFO - Running cycle 1/1 for kraken test... 04:16:42 INFO - TEST-INFO | started process 22013 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr1TOQY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:16:53 INFO - PROCESS | 22013 | RSS: Main: 145416192 04:16:53 INFO - PROCESS | 22013 | 04:16:56 INFO - PROCESS | 22013 | Cycle 1(1): loaded http://localhost:60326/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60326/tests/kraken/driver.html?testName=audio-beat-detection) 04:16:57 INFO - PROCESS | 22013 | RSS: Main: 194822144 04:16:57 INFO - PROCESS | 22013 | 04:16:59 INFO - PROCESS | 22013 | Cycle 1(1): loaded http://localhost:60326/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60326/tests/kraken/driver.html?testName=audio-dft) 04:17:00 INFO - PROCESS | 22013 | RSS: Main: 193544192 04:17:00 INFO - PROCESS | 22013 | 04:17:03 INFO - PROCESS | 22013 | Cycle 1(1): loaded http://localhost:60326/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60326/tests/kraken/driver.html?testName=audio-fft) 04:17:03 INFO - PROCESS | 22013 | RSS: Main: 279289856 04:17:03 INFO - PROCESS | 22013 | 04:17:05 INFO - PROCESS | 22013 | Cycle 1(1): loaded http://localhost:60326/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60326/tests/kraken/driver.html?testName=audio-oscillator) 04:17:06 INFO - PROCESS | 22013 | RSS: Main: 188321792 04:17:06 INFO - PROCESS | 22013 | 04:17:08 INFO - PROCESS | 22013 | Cycle 1(1): loaded http://localhost:60326/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60326/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:17:09 INFO - PROCESS | 22013 | RSS: Main: 188141568 04:17:09 INFO - PROCESS | 22013 | 04:17:12 INFO - PROCESS | 22013 | Cycle 1(1): loaded http://localhost:60326/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60326/tests/kraken/driver.html?testName=imaging-darkroom) 04:17:12 INFO - PROCESS | 22013 | RSS: Main: 223498240 04:17:12 INFO - PROCESS | 22013 | 04:17:16 INFO - PROCESS | 22013 | Cycle 1(1): loaded http://localhost:60326/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60326/tests/kraken/driver.html?testName=imaging-desaturate) 04:17:16 INFO - PROCESS | 22013 | RSS: Main: 224247808 04:17:16 INFO - PROCESS | 22013 | 04:17:19 INFO - PROCESS | 22013 | Cycle 1(1): loaded http://localhost:60326/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60326/tests/kraken/driver.html?testName=json-parse-financial) 04:17:20 INFO - PROCESS | 22013 | RSS: Main: 222658560 04:17:20 INFO - PROCESS | 22013 | 04:17:21 INFO - PROCESS | 22013 | Cycle 1(1): loaded http://localhost:60326/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60326/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:17:22 INFO - PROCESS | 22013 | RSS: Main: 201412608 04:17:22 INFO - PROCESS | 22013 | 04:17:24 INFO - PROCESS | 22013 | Cycle 1(1): loaded http://localhost:60326/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60326/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:17:24 INFO - PROCESS | 22013 | RSS: Main: 201912320 04:17:24 INFO - PROCESS | 22013 | 04:17:26 INFO - PROCESS | 22013 | Cycle 1(1): loaded http://localhost:60326/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60326/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:17:27 INFO - PROCESS | 22013 | RSS: Main: 209297408 04:17:27 INFO - PROCESS | 22013 | 04:17:29 INFO - PROCESS | 22013 | Cycle 1(1): loaded http://localhost:60326/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60326/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:17:30 INFO - PROCESS | 22013 | RSS: Main: 213217280 04:17:30 INFO - PROCESS | 22013 | 04:17:33 INFO - PROCESS | 22013 | Cycle 1(1): loaded http://localhost:60326/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60326/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:17:33 INFO - PROCESS | 22013 | RSS: Main: 212881408 04:17:33 INFO - PROCESS | 22013 | 04:17:35 INFO - PROCESS | 22013 | Cycle 1(1): loaded http://localhost:60326/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60326/tests/kraken/driver.html?testName=ai-astar) 04:17:35 INFO - PROCESS | 22013 | RSS: Main: 254902272 04:17:35 INFO - PROCESS | 22013 | 04:17:35 INFO - PROCESS | 22013 | __start_tp_report 04:17:35 INFO - PROCESS | 22013 | _x_x_mozilla_page_load 04:17:35 INFO - PROCESS | 22013 | _x_x_mozilla_page_load_details 04:17:35 INFO - PROCESS | 22013 | |i|pagename|runs| 04:17:35 INFO - PROCESS | 22013 | |0;ai-astar;109;104;110;108;109;108;109;110;107;108 04:17:35 INFO - PROCESS | 22013 | |1;audio-beat-detection;155;123;126;190;124;125;149;123;162;127 04:17:35 INFO - PROCESS | 22013 | |2;audio-dft;161;162;161;162;162;165;160;160;160;160 04:17:35 INFO - PROCESS | 22013 | |3;audio-fft;74;75;76;125;83;75;76;76;98;75 04:17:35 INFO - PROCESS | 22013 | |4;audio-oscillator;85;85;120;84;85;85;123;83;84;135 04:17:35 INFO - PROCESS | 22013 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;118;117 04:17:35 INFO - PROCESS | 22013 | |6;imaging-darkroom;145;145;146;145;146;146;146;146;145;146 04:17:35 INFO - PROCESS | 22013 | |7;imaging-desaturate;94;94;95;95;96;95;95;95;95;95 04:17:35 INFO - PROCESS | 22013 | |8;json-parse-financial;51;54;52;52;52;53;52;53;52;52 04:17:35 INFO - PROCESS | 22013 | |9;json-stringify-tinderbox;59;59;59;59;59;58;59;59;59;59 04:17:35 INFO - PROCESS | 22013 | |10;stanford-crypto-aes;79;75;76;75;81;77;80;83;115;81 04:17:35 INFO - PROCESS | 22013 | |11;stanford-crypto-ccm;126;116;115;116;121;134;126;119;121;129 04:17:35 INFO - PROCESS | 22013 | |12;stanford-crypto-pbkdf2;150;154;151;152;158;154;154;152;151;162 04:17:35 INFO - PROCESS | 22013 | |13;stanford-crypto-sha256-iterative;63;61;62;63;63;62;61;61;65;60 04:17:35 INFO - PROCESS | 22013 | __end_tp_report 04:17:35 INFO - PROCESS | 22013 | __start_cc_report 04:17:35 INFO - PROCESS | 22013 | _x_x_mozilla_cycle_collect,1586 04:17:35 INFO - PROCESS | 22013 | __end_cc_report 04:17:35 INFO - PROCESS | 22013 | __startTimestamp1467544655515__endTimestamp 04:17:35 INFO - PROCESS | 22013 | 04:17:35 INFO - PROCESS | 22013 | ------- Summary: start ------- 04:17:35 INFO - PROCESS | 22013 | Number of tests: 14 04:17:35 INFO - PROCESS | 22013 | 04:17:35 INFO - PROCESS | 22013 | [#0] ai-astar Cycles:10 Average:108.20 Median:109.00 stddev:1.75 (1.6%) stddev-sans-first:1.83 04:17:35 INFO - PROCESS | 22013 | Values: 109.0 104.0 110.0 108.0 109.0 108.0 109.0 110.0 107.0 108.0 04:17:35 INFO - PROCESS | 22013 | 04:17:35 INFO - PROCESS | 22013 | [#1] audio-beat-detection Cycles:10 Average:140.40 Median:138.00 stddev:22.88 (16.6%) stddev-sans-first:23.65 04:17:35 INFO - PROCESS | 22013 | Values: 155.0 123.0 126.0 190.0 124.0 125.0 149.0 123.0 162.0 127.0 04:17:35 INFO - PROCESS | 22013 | 04:17:35 INFO - PROCESS | 22013 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.57 (1.0%) stddev-sans-first:1.66 04:17:35 INFO - PROCESS | 22013 | Values: 161.0 162.0 161.0 162.0 162.0 165.0 160.0 160.0 160.0 160.0 04:17:35 INFO - PROCESS | 22013 | 04:17:35 INFO - PROCESS | 22013 | [#3] audio-fft Cycles:10 Average:83.30 Median:76.00 stddev:16.36 (21.5%) stddev-sans-first:17.00 04:17:35 INFO - PROCESS | 22013 | Values: 74.0 75.0 76.0 125.0 83.0 75.0 76.0 76.0 98.0 75.0 04:17:35 INFO - PROCESS | 22013 | 04:17:35 INFO - PROCESS | 22013 | [#4] audio-oscillator Cycles:10 Average:96.90 Median:84.50 stddev:20.44 (24.2%) stddev-sans-first:21.22 04:17:35 INFO - PROCESS | 22013 | Values: 85.0 85.0 120.0 84.0 85.0 85.0 123.0 83.0 84.0 135.0 04:17:35 INFO - PROCESS | 22013 | 04:17:35 INFO - PROCESS | 22013 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:17:35 INFO - PROCESS | 22013 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 04:17:35 INFO - PROCESS | 22013 | 04:17:35 INFO - PROCESS | 22013 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 04:17:35 INFO - PROCESS | 22013 | Values: 145.0 145.0 146.0 145.0 146.0 146.0 146.0 146.0 145.0 146.0 04:17:35 INFO - PROCESS | 22013 | 04:17:35 INFO - PROCESS | 22013 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 04:17:35 INFO - PROCESS | 22013 | Values: 94.0 94.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 04:17:35 INFO - PROCESS | 22013 | 04:17:35 INFO - PROCESS | 22013 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.00 stddev:0.82 (1.6%) stddev-sans-first:0.73 04:17:35 INFO - PROCESS | 22013 | Values: 51.0 54.0 52.0 52.0 52.0 53.0 52.0 53.0 52.0 52.0 04:17:35 INFO - PROCESS | 22013 | 04:17:35 INFO - PROCESS | 22013 | [#9] json-stringify-tinderbox Cycles:10 Average:58.90 Median:59.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 04:17:35 INFO - PROCESS | 22013 | Values: 59.0 59.0 59.0 59.0 59.0 58.0 59.0 59.0 59.0 59.0 04:17:35 INFO - PROCESS | 22013 | 04:17:35 INFO - PROCESS | 22013 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:79.50 stddev:11.85 (14.9%) stddev-sans-first:12.51 04:17:35 INFO - PROCESS | 22013 | Values: 79.0 75.0 76.0 75.0 81.0 77.0 80.0 83.0 115.0 81.0 04:17:35 INFO - PROCESS | 22013 | 04:17:35 INFO - PROCESS | 22013 | [#11] stanford-crypto-ccm Cycles:10 Average:122.30 Median:123.50 stddev:6.29 (5.1%) stddev-sans-first:6.53 04:17:35 INFO - PROCESS | 22013 | Values: 126.0 116.0 115.0 116.0 121.0 134.0 126.0 119.0 121.0 129.0 04:17:35 INFO - PROCESS | 22013 | 04:17:35 INFO - PROCESS | 22013 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.80 Median:154.00 stddev:3.68 (2.4%) stddev-sans-first:3.63 04:17:35 INFO - PROCESS | 22013 | Values: 150.0 154.0 151.0 152.0 158.0 154.0 154.0 152.0 151.0 162.0 04:17:35 INFO - PROCESS | 22013 | 04:17:35 INFO - PROCESS | 22013 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.50 stddev:1.45 (2.3%) stddev-sans-first:1.50 04:17:35 INFO - PROCESS | 22013 | Values: 63.0 61.0 62.0 63.0 63.0 62.0 61.0 61.0 65.0 60.0 04:17:35 INFO - PROCESS | 22013 | -------- Summary: end -------- 04:17:35 INFO - PROCESS | 22013 | 04:17:36 INFO - TEST-INFO | 22013: exit 0 04:17:36 INFO - TEST-OK | kraken | took 61510ms 04:17:36 INFO - SUITE-END | took 1175s 04:17:36 INFO - Completed test suite (00:19:35) 04:17:36 INFO - javascript benchmark 04:17:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3341.8329083545823, 3348.1629592601857, 3375.898723038308, 3407.6421975692538, 3426.5374174486437, 5598.664080155194, 5684.602077854546, 5686.20393144959, 5687.345955215152, 5687.345955215152, 5571.4428557144265, 5592.6085174037835, 5610.438956104398, 5615.073512870382, 5619.634723742954, 4917.4344950330815, 5010.649254552182, 5056.898862022757, 5068.062408454439, 5099.796008159669, 5059.291699162101, 5094.949050509485, 5096.821611243608, 5100.15847385181, 5101.84694459165, 4999.575036121916, 5054.292399064134, 5084.923726144111, 5085.491450854922, 5093.617978651598, 5115.565176959963, 5144.6913185209005, 5147.022065807522, 5155.304033955405, 5184.792608295664, 4958.603311735053, 4981.103401387749, 4992.525710057539, 5063.038022775698, 5080.695158290514, 5352.999999999961, 5359.22291267764, 5371.650842695251, 5392.245085688007, 5418.349798024262, 5923.881522369528, 5963.850903727398, 5976.462118409364, 5977.3723759005115, 5979.820605381846, 6006.429389208019, 6009.429104235091, 6060.606060606091, 6075.787347442818, 6081.422264884829, 5684.204211410364, 5686.886262274773, 5706.543476521868, 5725.4274572543245, 5737.340205876294, 5962.195103661037, 6221.688915554295, 6221.751129954751, 6222.564420490522, 6230.968845155836, 5782.884342313214, 5821.621594596338, 5830.7959221427045, 5946.1972633693895, 5960.195373624592, 5957.076653118774, 5963.4931030862, 5972.910406343908, 6006.939930600638, 6012.518998480111, 5794.072948328248, 5849.064149736022, 5935.1987481690285, 5942.821715348547, 5951.940480595225, 5870.178175055496, 5951.226340575784, 5954.642721436728, 5968.104784282393, 6006.339302676702, 4564.041551274203, 4569.0, 4574.908501829945, 4577.56513131252, 4596.10375976688, 4002.5397079335667, 4056.492938382702, 4064.349704047338, 4094.590540945941, 4100.036491424573, 5760.423957604206, 5772.94227057724, 5792.594518383673, 5795.1886735857015, 5816.796412125555, 6089.847753806191, 6098.69506524672, 6099.725512351954, 6101.0, 6133.325334213233, 5513.228148059275, 5611.242482264924, 5627.409122042209, 5654.46282603152, 5689.118186681071, 5185.040767458032, 5207.609429292818, 5212.40057393397, 5216.26972223889, 5217.113090774577, 6223.097650840693, 6249.468795152372, 6273.686315684197, 6278.46633036197, 6278.686065696788, 5393.244945707683, 5842.883142337045, 6005.459508644243, 6042.728077236623, 6105.236845394325, 6255.844026658781, 6296.716647750771, 6296.968515157395, 6300.2754683212015, 6304.71628776697, 5785.913211301918, 5962.731677074456, 5970.850728731816, 5972.522198224218, 6009.429104235091, 5897.64614123154, 5909.261342332208, 5962.850928726816, 5991.730372133177, 5995.820125396245, 5854.531637469077, 5893.410658934073, 5896.734646940984, 5896.882062358814, 5898.144769008555, 5664.0654292043, 5811.854703632443, 5828.6211396259105, 5865.706714664335, 5881.0, 5767.134929760569, 5823.650580965155, 5886.764529418775, 5891.05743081105, 5919.644821310735, 5908.940910590839, 5927.940720592911, 6011.489023433057, 6015.608985415934, 6016.2479690038745, 5637.57718171147, 5706.0, 5759.769609215585, 5835.44563266489, 5851.941480585139], "value": 5532.411273720263, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.9941600583993, 647.3397134922379, 650.8958566629337, 653.5588477777501, 664.2759392262433, 33606.66393336066, 48504.272435913444, 49412.50587494124, 49420.0, 49486.752566237206, 48978.0, 49493.752531237296, 49545.0, 49550.0, 49565.0, 8101.351891848638, 9114.589843457044, 9319.860202096974, 11013.559457621686, 11289.943550282238, 10766.300190487633, 11223.887761122365, 11224.382658953795, 11234.157438192127, 11234.21360504765, 11211.551537938472, 11305.0, 11307.321560706385, 11310.660680179608, 11312.943435282812, 8156.429049966505, 10944.0, 11190.608328708537, 11200.103991680646, 11521.711957201052, 11054.281471704313, 11138.443077846156, 11139.387333696643, 11151.107911367153, 11152.330860148417, 46473.53526464726, 46776.76611616954, 46963.765181173876, 46969.530304696855, 47039.76480117612, 3636.2182130841998, 3641.417373220272, 3662.359087159763, 3744.569374521938, 3841.9807900960595, 35230.0, 35391.4691279631, 35628.287434251426, 35829.10427239314, 35895.0, 4677.602403795681, 4743.383360163191, 4826.372571565674, 4832.395950506187, 4859.198232291667, 387677.0, 391182.0, 393098.0, 394173.0, 394899.0, 39210.60789392127, 39907.60092399097, 69763.65118174478, 70455.0, 70475.0, 42355.57644423578, 42406.36390454145, 42576.0, 42617.57382426198, 42632.14735705269, 14963.326650300764, 16551.08969006716, 16786.49640510762, 16790.32838686439, 16811.243494042796, 12947.611571652866, 13309.201447913156, 13340.332983350987, 13738.313084345742, 13973.301334933212, 9372.39079459833, 9378.85931711025, 9379.765505862271, 9435.292353073546, 9459.810803783887, 3563.7505374624047, 3570.303790760777, 3644.7084233261276, 3669.3028324618235, 3670.853165873335, 1027.845823126537, 1117.2067831839322, 1133.8582677165355, 1160.3907948327196, 1220.9023278137727, 34699.826500867835, 34748.47877281843, 34926.0, 35032.47451288233, 35086.64913350885, 1192.0, 1222.370479203211, 1239.8450193725785, 1306.7321199154342, 1325.2578556008473, 17961.0, 18146.09269536518, 18173.273069077088, 18191.0, 18219.635607288044, 658856.0, 664779.0, 667459.0, 667485.0, 669379.0, 65005.67497162484, 65601.39192344372, 65685.67157164279, 65757.34242657512, 65930.34069659242, 1364.5224171539883, 1432.4914655297428, 1466.2155746675692, 1474.3660226102663, 1498.3257534109694, 34350.48474272838, 34678.30643387169, 35498.29003419865, 35691.64308356987, 35944.820275898455, 55707.0, 55943.440565593824, 56400.0, 56425.153622694874, 56427.0, 441247.0, 441961.0, 442279.0, 444933.0, 446059.0, 28428.57357139603, 30610.540841886945, 32102.839485802422, 32222.35555288928, 33640.663593364734, 50999.74500127476, 53500.0, 53943.0, 54109.0, 54622.0, 44109.33835992398, 44419.33370999373, 44755.776221118685, 45260.0, 45498.0, 43857.56142438662, 44264.0, 44443.0, 44912.55087449084, 45009.32486012647, 43773.78113109414, 44744.32883506685, 44795.0, 44972.10055798931, 45110.0, 36989.0, 39011.80494097511, 39369.40945885871, 39448.605513944494, 39953.20093598054, 29145.0, 29192.27019324534, 29443.558346625246, 29628.81736937363, 29728.405431891675], "value": 20988.22106874264, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.17516018923277, 425.80413010015394, 435.97912823901896, 440.9955900440997, 441.27850963674393, 18625.53436164095, 19460.12429440673, 20371.796282037194, 20848.0, 21019.57960840782, 19630.607387852233, 19634.70547941782, 19917.10373033213, 20093.09581068852, 20161.899190504064, 5722.914156287648, 5921.911171332434, 5962.8807423851495, 5969.5821292509545, 5973.940260597382, 5662.348829884575, 5883.470487656132, 5937.37657545958, 5952.940470595304, 5972.104184372357, 5991.670458124801, 5995.790147344844, 6003.969980150093, 6012.3687012863675, 6023.36754640763, 6032.366601506845, 6389.6805159741825, 6569.244536878273, 6597.208334999783, 6601.603903765766, 5530.170474428827, 5780.913286300709, 5791.478766910956, 5808.041673123929, 5812.534997200256, 14468.348924298327, 14475.638109047359, 14530.128192308495, 14603.48887788933, 14659.0, 2396.616541353375, 2420.1529464687396, 2445.6209287560455, 2520.420303330244, 2601.713811480736, 9989.300748947577, 10187.286889917708, 10629.787404251872, 10823.24237303389, 11176.21766476347, 1858.9163487643089, 1873.2694249242807, 1903.562180698447, 1924.6439408709434, 2015.2946468735972, 74761.0, 76417.61791191009, 77292.22707772907, 81666.0, 85387.5730621349, 11324.886751132548, 11644.301341919512, 11728.120390970711, 11874.1094417919, 11979.401029948467, 16447.506574802774, 16491.34034638625, 16633.417830375878, 16740.0, 16786.74819877703, 8420.410571260076, 8647.783805404915, 8682.56888071341, 8776.956115219511, 8944.597493112826, 8982.0, 9010.63957441695, 9070.909290907139, 9072.50101244438, 9170.770730731785, 4964.081644895634, 4991.359204551667, 5017.523335283142, 5156.9742151289, 5158.432572417031, 1973.2205778717325, 2011.7911930470875, 2070.109852763296, 2091.801278878504, 2142.507223338641, 471.8324994626927, 809.0614886731481, 995.5569771451779, 1036.683811437519, 1151.758130792543, 11506.76986460283, 11734.767849375692, 11846.348450835287, 12420.937895310646, 12621.558245461365, 489.5789620926001, 494.04402481198997, 505.36576596371316, 507.031569701875, 519.706365903271, 6607.108040414579, 6668.966655166693, 6677.666116694146, 6712.932870671329, 6717.596944183365, 399011.0, 399334.0, 402085.0, 541423.0, 570059.0, 103916.0, 109259.45370273097, 109264.0, 109543.0, 110532.4473377628, 1089.8746644135867, 1094.7865166292656, 1135.6593022093505, 1146.5356530605118, 1152.4410660829492, 13622.591322260349, 16667.583310417336, 17453.040082795567, 17929.462116136016, 17974.19116139803, 41861.37207941822, 43423.34864977091, 44380.334294984954, 44438.11123777571, 45306.32040519461, 57837.71081144567, 59328.110078349724, 59533.10700339585, 60346.0, 60520.39479605148, 8600.182982616641, 8749.387542871938, 8811.65193576497, 8943.272301947709, 8956.193942545202, 9348.439093654402, 11871.525138994344, 12267.447964841425, 12298.569550066062, 12528.436220370288, 11072.889271107186, 11074.889251107708, 11171.608993685182, 11175.72060698489, 11293.71765705864, 10941.726456838323, 11048.944755276172, 11051.0, 11087.833682494931, 11346.092312614806, 11022.393768342497, 11189.384583847966, 11256.7748645025, 11318.09455243595, 11366.659000230007, 8323.209295116954, 8337.874931876147, 8357.916420835714, 8360.707375241838, 8527.957360213408, 10831.729206769895, 11153.498092586015, 11213.439328033728, 11228.38243896561, 11306.4912078955], "value": 8893.615320494691, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1321.5837011341428, 1436.8634979676926, 1447.8841692664587, 1483.2138966347832, 1876.0807204469813, 8847.33644976627, 9207.033261507546, 9247.630094796208, 9486.33595648305, 9500.904990950088, 9188.632454701803, 9395.577199026044, 9396.48319342436, 9400.529973501314, 9408.20030297424, 2471.7651823076826, 2496.5131799299143, 2497.5878979968284, 2497.6628155199087, 2499.1128149506844, 2521.936951576207, 2579.548578998677, 2581.3288544978345, 2582.948341033178, 2583.8837252323597, 2436.415260337524, 2457.4839283750434, 2518.3326418499114, 2521.420073383114, 2522.8738563071865, 2455.017992802875, 2466.087547607388, 2473.8144639152138, 2484.4782595654933, 2504.0860086068637, 2415.951680966371, 2417.9516409671883, 2440.780329770329, 2443.15711079679, 2462.347477918353, 8967.730968070902, 9199.862002069975, 9233.445993240428, 9292.628294868196, 9297.209737172348, 5452.836414907559, 5571.9442805572235, 5586.1062230043, 5586.608937374385, 5587.944120558824, 3482.4253998090285, 3517.437210046406, 3546.8758593449365, 3561.305545418644, 3568.982155089234, 1095.7205912492343, 1102.399192440122, 1174.2074099982563, 1183.828344889986, 1201.4593432955119, 12832.679183020406, 12993.545225917047, 12998.610041698765, 13004.804927925994, 13007.804882926765, 4855.854324370274, 4864.975675121602, 4895.388076490439, 4907.975460122677, 4977.0, 9918.0, 10018.899811001942, 10076.49617519121, 10078.596856125672, 10102.040306170902, 5496.038193316153, 5499.092649712833, 5502.284702988586, 5502.339719233718, 5503.724813759376, 4575.382323386367, 4850.151223535867, 5035.395752509649, 5212.087884620177, 5223.817166399158, 4073.348264277701, 4079.286124928185, 4096.1193343431305, 4147.357159640261, 4152.252594532953, 1224.0758227538329, 1230.7415442756942, 1236.0358920042381, 1236.8330275412884, 1260.8565438754154, 842.2251528593708, 1028.9022542858415, 1047.9056884880397, 1075.8547596074586, 1077.1490522487147, 6338.461230795342, 6419.775307864203, 6432.935670643327, 6444.7744328948265, 6445.484361251089, 505.75723652646934, 520.6901893373437, 521.7834598641597, 526.5208660119273, 685.5441131647498, 4297.978510107492, 4328.718633288826, 4370.366296886934, 4382.802773875183, 4485.215087359699, 11307.604233851776, 11562.537498499965, 11659.88340116588, 11698.824517632242, 11730.70673233159, 11034.724131896766, 11480.081593472501, 11559.133065019989, 11597.246178998337, 11599.6520104397, 8753.168448997336, 8885.955570222237, 8890.199882010651, 8917.955410223038, 8942.105789421135, 6398.5201109916015, 6587.571807832475, 6629.204495460575, 6685.064091027358, 6693.364130407604, 10278.280520363802, 10548.789024219319, 10555.63055293061, 10659.307145035547, 10728.302660327054, 9618.038196180327, 10755.623553175914, 10835.837462437912, 10875.619353322596, 10889.455527223765, 7718.3053525183, 7949.244821741925, 7950.681972721027, 8077.27304542594, 8087.595620219083, 8075.717349892726, 8242.670293188205, 8258.628361723617, 8504.277136443225, 8618.181272779077, 7553.660085296285, 7665.923340766521, 7727.6136193188995, 7986.800329991796, 8169.836603268021, 8084.595770211348, 8112.310453611273, 8125.553094579618, 8134.389920755849, 8264.504129752235, 7402.1857595665515, 7461.888071679038, 7508.774736757906, 7509.4367922404945, 7519.962400188183, 5262.684238945675, 5465.426130256425, 5499.422560631237, 5585.636933599303, 5760.193572899713, 5413.53984911287, 5617.915731264116, 5656.377798442086, 5708.143778433268, 5801.564882633735], "value": 4791.806494336601, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.0101513731278, 359.31371081234846, 361.56431500042453, 362.9219717760681, 365.82440428594276, 5522.723863806808, 5558.471945165208, 5567.137093750465, 5578.9163162552595, 5582.855514619503, 5461.0, 5519.0, 5523.475269849368, 5532.723363831802, 5542.861428464291, 4195.671402371675, 4281.571842815709, 4301.741895486281, 4321.243782338078, 4331.938675024623, 4277.0, 4307.267764480031, 4309.267424537836, 4313.784310784464, 4369.80335884886, 4279.72181808183, 4288.1423715256915, 4299.247631664462, 4317.244482215616, 4324.74051556906, 4173.4157217989505, 4280.357946308048, 4287.142571485715, 4291.935620965688, 4317.935230971522, 3772.2832661794173, 3790.7915064671433, 3795.867144649924, 3798.0, 3812.3519001769764, 5337.626366154371, 5360.249565060894, 5362.705051222181, 5365.195220716884, 5366.9463305366835, 4802.567768900781, 4979.551840334388, 4980.452150263468, 4990.725510096943, 5005.449400565934, 5715.0855863062125, 5721.427857214287, 5785.681787501686, 5795.478406943395, 5816.190395291091, 4159.438475805758, 4183.91632167355, 4195.0, 4202.327627579572, 4239.6221228100685, 6014.578979471439, 6023.939760602381, 6064.60580062299, 6067.514598832127, 6149.692515374258, 4268.423762791983, 4286.742795432284, 4287.97856010718, 4290.978545107255, 4291.74249545022, 4345.717528360647, 4350.108227813291, 4351.823169086584, 4352.325389564622, 4356.6514678825615, 4768.690035147773, 4928.334674818925, 4949.381327334083, 5001.124803159432, 5019.268352418409, 5757.193992840922, 5797.913031304533, 5863.941360586425, 5871.442212989759, 5925.170476133345, 1463.4146341463286, 1475.579459853958, 1490.0538158269576, 1492.6790739990954, 1495.835458099608, 909.1771946388529, 913.9223166030829, 920.9171174594319, 974.1573538888811, 978.3396207560011, 4977.228529577921, 4982.501749824988, 4992.301077849104, 4995.375578052744, 5009.499050095034, 5308.442613525524, 5310.734463276898, 5318.946810531923, 5327.627066105335, 5337.919931201035, 5025.271335656309, 5025.723585202849, 5092.490750924878, 5300.92048619271, 5800.854978625483, 3222.726068284222, 3252.6259480160084, 3255.9837200813845, 3256.886008989721, 3258.4297747894498, 6075.969620151871, 6292.9233352994315, 6305.738852229572, 6307.445484578753, 6313.494920406357, 5893.852653683693, 6042.909356359658, 6093.634381937098, 6108.847278817976, 6141.447269745744, 5999.900084927776, 6128.835521251037, 6134.5277133488535, 6151.569390142647, 6177.505799536027, 5861.443162899518, 5957.302168881848, 5970.31341395745, 6032.426919442646, 6033.909491357721, 5884.293225116495, 5904.9704751475965, 5905.5570832186895, 5916.911246331222, 5923.170756094064, 6081.411966939527, 6146.692665366624, 6161.353057928853, 6167.136600875791, 6204.317525072148, 4106.876793696194, 4233.751043442254, 4247.723897946624, 4271.893202669834, 4278.379634952977, 5929.229200203946, 5991.430814072656, 5996.400359964143, 6000.519958403404, 6003.429674180946, 5816.3892791258, 5857.502112320501, 5860.560457965585, 5894.410558944071, 5900.232969713909, 5639.182318563868, 5778.739956701875, 5815.912761308499, 5816.970915145397, 5831.912521312099, 5695.515881150149, 5710.685912274865, 5715.571332150189, 5727.198192253171, 5761.654300741969, 5645.266115405136, 5876.529877609695, 5887.970560147343, 5893.734781934738, 5990.716637604134, 5708.686022268649, 5769.711514424178, 5829.59192856513, 5836.533077353886, 5858.443447872445], "value": 4409.909075754612, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [758.1395116542723, 798.9280964713174, 835.6156168162645, 871.5467956662532, 889.875417441558, 16330.591735206612, 17192.914035429807, 17194.82805171948, 17219.225134868928, 17234.82765172348, 14750.0, 14754.778678319833, 14794.926025369858, 14875.628109297273, 14915.925420372883, 708.7909066825273, 835.9540225287607, 852.3607294529103, 864.723288547665, 867.7657032601194, 852.4799872078028, 853.7353420439683, 857.438377862501, 858.4205661178679, 858.7252079334615, 906.8685040669098, 914.0128661046087, 914.3325372478095, 916.1754421021068, 916.7937214126835, 740.774063910507, 768.7271018788306, 908.6819613135383, 909.7179874238974, 910.9089091090871, 562.3982338897381, 647.679398697643, 665.9134312539339, 666.6766618190173, 667.5494041521953, 15622.296996635065, 15680.843191568052, 15694.843051569453, 15751.2124393781, 15760.60598485047, 14289.642758931006, 14476.34856431463, 14545.0, 14596.124232545975, 14679.119252844863, 12139.635810925687, 12645.367731613474, 12658.936705316415, 13006.284654344006, 13170.27563484008, 4623.74569398683, 4627.421572303462, 4632.698874573142, 4694.319323698045, 4713.622910167179, 85761.57119214427, 86407.0, 86709.13290867137, 87686.56156719239, 87951.56024219838, 12110.81833772494, 12215.694607634703, 12243.0, 12259.387030648431, 12561.811572826415, 20198.29305974284, 21260.78739212619, 21405.0, 21438.78561214399, 21450.57098858014, 8890.422122562013, 8961.507117108491, 8974.14745599167, 9110.0, 9166.587503562223, 5066.847994560169, 5071.061853557104, 5213.322268105122, 5279.1289437243195, 5362.061639213122, 3517.1734642359024, 3601.369760291991, 3605.94591081134, 3609.9639003609627, 3616.168281295264, 695.3081683724727, 702.1574111066639, 742.866284068862, 775.8525880082766, 789.1161898673407, 690.6374153569316, 716.6631683108931, 755.1353700013453, 774.0169984120135, 778.1479280188184, 10388.480575971322, 10554.050135487843, 10749.892501075046, 10898.291611045415, 10932.344059356465, 633.9207599050119, 776.7786180938518, 782.1669921533548, 784.7135795434739, 801.410962942237, 5213.843584692389, 5251.501107394792, 5266.789328426897, 5296.549793267538, 5345.465453454701, 79219.20780792234, 79510.6024469874, 79747.8037829433, 86833.56583217044, 127420.0, 69536.6523167381, 69696.0, 72445.2755472449, 83156.58421707853, 105812.0, 64653.0, 91985.0, 95244.52377738067, 97031.0, 98191.50904245433, 9846.359986600848, 10056.195504359488, 10115.696529104138, 10156.44139572301, 10237.181025517792, 51656.22515662193, 52106.0, 53678.0, 54203.45796542142, 54372.72813635907, 67165.0, 67653.3234667647, 68020.31979680338, 75745.0, 79171.0, 13223.735525289248, 13478.0, 13701.657458563615, 14142.929285353508, 14380.42478300898, 15127.915482725044, 15741.134237617041, 15742.449014284903, 15803.446879359168, 16044.197790110215, 10724.624638137628, 14319.785203222169, 14841.480548181195, 14975.850241497446, 15155.242237887842, 14652.853471465149, 14751.92624036916, 14917.552473425814, 15310.0, 15746.370145194063, 13142.737145257233, 13151.079424440197, 13189.472421103048, 13321.86678133245, 13747.656308592364, 11901.0, 12062.396880156133, 12409.441575129322, 12442.377881105727, 12554.183978041397, 11883.58407455735, 12259.264444133381, 12411.0, 12466.626001219978, 12785.48858045705], "value": 7899.78073813099, "unit": "score"}], "name": "dromaeo_css", "value": 7460.349935446225, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 104.0, 110.0, 108.0, 109.0, 108.0, 109.0, 110.0, 107.0, 108.0], "value": 108.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 123.0, 126.0, 190.0, 124.0, 125.0, 149.0, 123.0, 162.0, 127.0], "value": 140.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 162.0, 162.0, 165.0, 160.0, 160.0, 160.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 125.0, 83.0, 75.0, 76.0, 76.0, 98.0, 75.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 120.0, 84.0, 85.0, 85.0, 123.0, 83.0, 84.0, 135.0], "value": 96.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 54.0, 52.0, 52.0, 52.0, 53.0, 52.0, 53.0, 52.0, 52.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 59.0, 58.0, 59.0, 59.0, 59.0, 59.0], "value": 58.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 75.0, 76.0, 75.0, 81.0, 77.0, 80.0, 83.0, 115.0, 81.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 116.0, 115.0, 116.0, 121.0, 134.0, 126.0, 119.0, 121.0, 129.0], "value": 122.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 154.0, 151.0, 152.0, 158.0, 154.0, 154.0, 152.0, 151.0, 162.0], "value": 153.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 62.0, 63.0, 63.0, 62.0, 61.0, 61.0, 65.0, 60.0], "value": 62.1, "unit": "score"}], "name": "kraken", "value": 1479.3, "alertThreshold": 2.0}]} 04:17:36 INFO - Return code: 0 04:17:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:17:36 ERROR - # TBPL SUCCESS # 04:17:36 INFO - Running post-action listener: _resource_record_post_action 04:17:36 INFO - ##### 04:17:36 INFO - ##### Finished run-tests step (success) 04:17:36 INFO - ##### 04:17:36 INFO - Running post-run listener: _resource_record_post_run 04:17:36 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8192; Write bytes: 504832000; Read time: 564; Write time: 1525960 04:17:36 INFO - TinderboxPrint: CPU usage
13.2% 04:17:36 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 564 04:17:36 INFO - TinderboxPrint: I/O write bytes / time
504,832,000 / 1,525,960 04:17:36 INFO - TinderboxPrint: CPU idle
8,257.2 (86.8%) 04:17:36 INFO - TinderboxPrint: CPU user
1,197.5 (12.6%) 04:17:36 INFO - TinderboxPrint: Swap in / out
0 / 0 04:17:36 INFO - install - Wall time: 16s; CPU: 21.0%; Read bytes: 0; Write bytes: 253681664; Read time: 0; Write time: 1135916 04:17:36 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 8192; Write bytes: 251150336; Read time: 564; Write time: 390044 04:17:37 INFO - Running post-run listener: _upload_blobber_files 04:17:37 INFO - Blob upload gear active. 04:17:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:17:37 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:17:37 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:17:37 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:17:37 INFO - (blobuploader) - INFO - Open directory for files ... 04:17:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:17:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:17:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:17:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:17:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:17:41 INFO - (blobuploader) - INFO - Done attempting. 04:17:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:17:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:17:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:17:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:17:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:17:41 INFO - (blobuploader) - INFO - Done attempting. 04:17:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:17:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:17:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:17:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:17:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:17:42 INFO - (blobuploader) - INFO - Done attempting. 04:17:42 INFO - (blobuploader) - INFO - Iteration through files over. 04:17:42 INFO - Return code: 0 04:17:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:17:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:17:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3a6aaffb0e33364b45c9f42aa58a692147b5e6ba8e5156aed64ace58ca25049c95872d0ed03c73da7bff2b31f8d29aa4656a389993718dc930adebfaaed63780", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47ebc956361948561b1909ce0cb2c72eb6de0d60c70ad4d1ad6a12f5a8fe7a34fd3cd7be9909836c2af7d084d7779905d85afdbad4100e70a65f667e43eebe26", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4d161884ba0789718be651d9ce8dccb83b583affce1bad7f677099dac6e243324603e84095bbaf80f71a8a38827157f4e12eab62f3e839c14a8bb158233ef605"} 04:17:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:17:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:17:42 INFO - Contents: 04:17:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3a6aaffb0e33364b45c9f42aa58a692147b5e6ba8e5156aed64ace58ca25049c95872d0ed03c73da7bff2b31f8d29aa4656a389993718dc930adebfaaed63780", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47ebc956361948561b1909ce0cb2c72eb6de0d60c70ad4d1ad6a12f5a8fe7a34fd3cd7be9909836c2af7d084d7779905d85afdbad4100e70a65f667e43eebe26", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4d161884ba0789718be651d9ce8dccb83b583affce1bad7f677099dac6e243324603e84095bbaf80f71a8a38827157f4e12eab62f3e839c14a8bb158233ef605"} 04:17:42 INFO - Running post-run listener: copy_logs_to_upload_dir 04:17:42 INFO - Copying logs to upload dir... 04:17:42 INFO - mkdir: /builds/slave/test/build/upload/logs 04:17:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.478575 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-03 04:17:42.204103) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-03 04:17:42.209086) ========= 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=df17445c3590ff7897617a0e00000225-1467542753.676176-570352329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3a6aaffb0e33364b45c9f42aa58a692147b5e6ba8e5156aed64ace58ca25049c95872d0ed03c73da7bff2b31f8d29aa4656a389993718dc930adebfaaed63780", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47ebc956361948561b1909ce0cb2c72eb6de0d60c70ad4d1ad6a12f5a8fe7a34fd3cd7be9909836c2af7d084d7779905d85afdbad4100e70a65f667e43eebe26", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4d161884ba0789718be651d9ce8dccb83b583affce1bad7f677099dac6e243324603e84095bbaf80f71a8a38827157f4e12eab62f3e839c14a8bb158233ef605"} build_url:https://queue.taskcluster.net/v1/task/cGYNYlCVR4qILWx_V2WL6A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/cGYNYlCVR4qILWx_V2WL6A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3a6aaffb0e33364b45c9f42aa58a692147b5e6ba8e5156aed64ace58ca25049c95872d0ed03c73da7bff2b31f8d29aa4656a389993718dc930adebfaaed63780", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47ebc956361948561b1909ce0cb2c72eb6de0d60c70ad4d1ad6a12f5a8fe7a34fd3cd7be9909836c2af7d084d7779905d85afdbad4100e70a65f667e43eebe26", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4d161884ba0789718be651d9ce8dccb83b583affce1bad7f677099dac6e243324603e84095bbaf80f71a8a38827157f4e12eab62f3e839c14a8bb158233ef605"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-03 04:17:42.237631) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 04:17:42.238062) ========= 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=df17445c3590ff7897617a0e00000225-1467542753.676176-570352329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 04:17:42.319422) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-03 04:17:42.321004) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-03 04:17:42.321313) ========= ========= Total master_lag: 0.21 =========