builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-036 starttime: 1467542100.61 results: success (0) buildid: 20160703010121 builduid: 183136f23601454aa3805948bf59665b revision: 1aa23cad1885319a42c69e0cc445a919abd24a14 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-03 03:35:00.611298) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-03 03:35:00.611724) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-03 03:35:00.612029) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-03 03:35:00.627574) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:35:00.627897) ========= 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=14ef55db36f7623abb31b9cf000001d5-1467541942.376890-256204262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-03 03:35: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.1M=0s 2016-07-03 03:35:01 (38.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126797 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:35:00.768984) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:35:00.769323) ========= 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=14ef55db36f7623abb31b9cf000001d5-1467541942.376890-256204262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020634 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:35:00.818676) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-03 03:35:00.819009) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1aa23cad1885319a42c69e0cc445a919abd24a14 --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 1aa23cad1885319a42c69e0cc445a919abd24a14 --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=14ef55db36f7623abb31b9cf000001d5-1467541942.376890-256204262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-03 03:35:01,472 truncating revision to first 12 chars 2016-07-03 03:35:01,472 Setting DEBUG logging. 2016-07-03 03:35:01,472 attempt 1/10 2016-07-03 03:35:01,472 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1aa23cad1885?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-03 03:35:02,586 unpacking tar archive at: mozilla-aurora-1aa23cad1885/testing/mozharness/ program finished with exit code 0 elapsedTime=1.458069 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-03 03:35:02.291280) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-03 03:35:02.291617) ========= script_repo_revision: 1aa23cad1885319a42c69e0cc445a919abd24a14 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-03 03:35:02.292024) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-03 03:35:02.292340) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-03 03:35:02.303018) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-03 03:35:02.303437) ========= /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=14ef55db36f7623abb31b9cf000001d5-1467541942.376890-256204262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:35:03 INFO - MultiFileLogger online at 20160703 03:35:03 in /builds/slave/test 03:35:03 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:35:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:35:03 INFO - {'append_to_log': False, 03:35:03 INFO - 'base_work_dir': '/builds/slave/test', 03:35:03 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:35:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:35:03 INFO - 'branch': 'Mozilla-Aurora', 03:35:03 INFO - 'buildbot_json_path': 'buildprops.json', 03:35:03 INFO - 'config_files': ('talos/linux_config.py',), 03:35:03 INFO - 'default_actions': ('clobber', 03:35:03 INFO - 'read-buildbot-config', 03:35:03 INFO - 'download-and-extract', 03:35:03 INFO - 'populate-webroot', 03:35:03 INFO - 'create-virtualenv', 03:35:03 INFO - 'install', 03:35:03 INFO - 'run-tests'), 03:35:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:35:03 INFO - 'download_minidump_stackwalk': True, 03:35:03 INFO - 'download_symbols': 'ondemand', 03:35:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:35:03 INFO - 'tooltool.py': '/tools/tooltool.py', 03:35:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:35:03 INFO - '/tools/misc-python/virtualenv.py')}, 03:35:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:35:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:35:03 INFO - 'installer_path': 'installer.exe', 03:35:03 INFO - 'log_level': 'info', 03:35:03 INFO - 'log_name': 'talos', 03:35:03 INFO - 'log_to_console': True, 03:35:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:35:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:35:03 INFO - 'opt_config_files': (), 03:35:03 INFO - 'pip_index': False, 03:35:03 INFO - 'sps_profile': False, 03:35:03 INFO - 'sps_profile_interval': 0, 03:35:03 INFO - 'suite': 'dromaeojs', 03:35:03 INFO - 'system_bits': '32', 03:35:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:35:03 INFO - 'title': 'talos-linux64-ix-036', 03:35:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:35:03 INFO - 'use_talos_json': True, 03:35:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:35:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:35:03 INFO - 'work_dir': 'build'} 03:35:03 INFO - ##### 03:35:03 INFO - ##### Running clobber step. 03:35:03 INFO - ##### 03:35:03 INFO - Running pre-action listener: _resource_record_pre_action 03:35:03 INFO - Running main action method: clobber 03:35:03 INFO - rmtree: /builds/slave/test/build 03:35:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:35:04 INFO - Running post-action listener: _resource_record_post_action 03:35:04 INFO - ##### 03:35:04 INFO - ##### Finished clobber step (success) 03:35:04 INFO - ##### 03:35:04 INFO - ##### 03:35:04 INFO - ##### Running read-buildbot-config step. 03:35:04 INFO - ##### 03:35:04 INFO - Running pre-action listener: _resource_record_pre_action 03:35:04 INFO - Running main action method: read_buildbot_config 03:35:04 INFO - Using buildbot properties: 03:35:04 INFO - { 03:35:04 INFO - "project": "", 03:35:04 INFO - "product": "firefox", 03:35:04 INFO - "script_repo_revision": "production", 03:35:04 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:35:04 INFO - "repository": "", 03:35:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:35:04 INFO - "buildid": "20160703010121", 03:35:04 INFO - "pgo_build": "True", 03:35:04 INFO - "basedir": "/builds/slave/test", 03:35:04 INFO - "buildnumber": 340, 03:35:04 INFO - "slavename": "talos-linux64-ix-036", 03:35:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:35:04 INFO - "platform": "ubuntu64_hw", 03:35:04 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:35:04 INFO - "branch": "mozilla-aurora", 03:35:04 INFO - "repo_path": "releases/mozilla-aurora", 03:35:04 INFO - "revision": "1aa23cad1885319a42c69e0cc445a919abd24a14", 03:35:04 INFO - "stage_platform": "linux64-pgo", 03:35:04 INFO - "builduid": "183136f23601454aa3805948bf59665b", 03:35:04 INFO - "slavebuilddir": "test" 03:35:04 INFO - } 03:35:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/ByaYG22TSOi3QRl31uNTTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:35:04 INFO - Running post-action listener: _resource_record_post_action 03:35:04 INFO - ##### 03:35:04 INFO - ##### Finished read-buildbot-config step (success) 03:35:04 INFO - ##### 03:35:04 INFO - ##### 03:35:04 INFO - ##### Running download-and-extract step. 03:35:04 INFO - ##### 03:35:04 INFO - Running pre-action listener: _resource_record_pre_action 03:35:04 INFO - Running main action method: download_and_extract 03:35:04 INFO - mkdir: /builds/slave/test/build/tests 03:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:04 INFO - https://queue.taskcluster.net/v1/task/ByaYG22TSOi3QRl31uNTTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:35:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ByaYG22TSOi3QRl31uNTTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:35:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ByaYG22TSOi3QRl31uNTTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:35:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ByaYG22TSOi3QRl31uNTTw/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:35:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ByaYG22TSOi3QRl31uNTTw/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:35:05 INFO - Downloaded 1361 bytes. 03:35:05 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:35:05 INFO - Using the following test package requirements: 03:35:05 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:35:05 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:35:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:35:05 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:35:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:35:05 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:35:05 INFO - u'jsshell-linux-x86_64.zip'], 03:35:05 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:35:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:35:05 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:35:05 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:35:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:35:05 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:35:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:35:05 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:35:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:35:05 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:35:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:35:05 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:35: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:35:05 INFO - https://queue.taskcluster.net/v1/task/ByaYG22TSOi3QRl31uNTTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:35:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ByaYG22TSOi3QRl31uNTTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:35:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ByaYG22TSOi3QRl31uNTTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:35:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ByaYG22TSOi3QRl31uNTTw/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:35:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ByaYG22TSOi3QRl31uNTTw/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:35:06 INFO - Downloaded 24526042 bytes. 03:35:06 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:35:06 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:35:08 INFO - Return code: 0 03:35: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:35: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:35:08 INFO - https://queue.taskcluster.net/v1/task/ByaYG22TSOi3QRl31uNTTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:35:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ByaYG22TSOi3QRl31uNTTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:35:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ByaYG22TSOi3QRl31uNTTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:35:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ByaYG22TSOi3QRl31uNTTw/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:35:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ByaYG22TSOi3QRl31uNTTw/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:35:09 INFO - Downloaded 24526042 bytes. 03:35:09 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:35:09 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:35:11 INFO - Return code: 0 03:35:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:11 INFO - https://queue.taskcluster.net/v1/task/ByaYG22TSOi3QRl31uNTTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:35:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ByaYG22TSOi3QRl31uNTTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:35:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ByaYG22TSOi3QRl31uNTTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:35:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ByaYG22TSOi3QRl31uNTTw/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:35:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ByaYG22TSOi3QRl31uNTTw/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:35:12 INFO - Downloaded 10833369 bytes. 03:35:12 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:35:12 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:35:12 INFO - Return code: 0 03:35:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:12 INFO - https://queue.taskcluster.net/v1/task/ByaYG22TSOi3QRl31uNTTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:35:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ByaYG22TSOi3QRl31uNTTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:35:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ByaYG22TSOi3QRl31uNTTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:35:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ByaYG22TSOi3QRl31uNTTw/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:35:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ByaYG22TSOi3QRl31uNTTw/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:35:16 INFO - Downloaded 63609692 bytes. 03:35:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ByaYG22TSOi3QRl31uNTTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:35:16 INFO - mkdir: /builds/slave/test/properties 03:35:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:35:16 INFO - Writing to file /builds/slave/test/properties/build_url 03:35:16 INFO - Contents: 03:35:16 INFO - build_url:https://queue.taskcluster.net/v1/task/ByaYG22TSOi3QRl31uNTTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:35:16 INFO - Running post-action listener: _resource_record_post_action 03:35:16 INFO - Running post-action listener: set_extra_try_arguments 03:35:16 INFO - ##### 03:35:16 INFO - ##### Finished download-and-extract step (success) 03:35:16 INFO - ##### 03:35:16 INFO - ##### 03:35:16 INFO - ##### Running populate-webroot step. 03:35:16 INFO - ##### 03:35:16 INFO - Running pre-action listener: _resource_record_pre_action 03:35:16 INFO - Running main action method: populate_webroot 03:35:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:35:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:35:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:35:16 INFO - '--tppagecycles', 03:35:16 INFO - '7'], 03:35:16 INFO - 'tests': ['tsvgm']}}, 03:35:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:35:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:35:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:35:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:35:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:35:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:35:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:16 INFO - 'talos_options': ['--disable-e10s'], 03:35:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:35:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:35:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:16 INFO - 'talos_options': ['--disable-e10s'], 03:35:16 INFO - 'tests': ['damp', 'tps']}, 03:35:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:16 INFO - 'tests': ['damp', 'tps']}, 03:35:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:35:16 INFO - 'tests': ['dromaeo_dom']}, 03:35:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:35:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:35:16 INFO - 'tests': ['a11yr', 03:35:16 INFO - 'ts_paint', 03:35:16 INFO - 'tpaint', 03:35:16 INFO - 'sessionrestore', 03:35:16 INFO - 'sessionrestore_no_auto_restore', 03:35:16 INFO - 'tabpaint']}, 03:35:16 INFO - 'other-e10s': {'tests': ['a11yr', 03:35:16 INFO - 'ts_paint', 03:35:16 INFO - 'tpaint', 03:35:16 INFO - 'sessionrestore', 03:35:16 INFO - 'sessionrestore_no_auto_restore', 03:35:16 INFO - 'tabpaint']}, 03:35:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:35:16 INFO - 'ts_paint', 03:35:16 INFO - 'tpaint', 03:35:16 INFO - 'sessionrestore', 03:35:16 INFO - 'sessionrestore_no_auto_restore', 03:35:16 INFO - 'tabpaint']}, 03:35:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:35:16 INFO - 'ts_paint', 03:35:16 INFO - 'tpaint', 03:35:16 INFO - 'sessionrestore', 03:35:16 INFO - 'sessionrestore_no_auto_restore', 03:35:16 INFO - 'tabpaint']}, 03:35:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:35:16 INFO - 'tests': ['a11yr', 03:35:16 INFO - 'ts_paint', 03:35:16 INFO - 'tpaint', 03:35:16 INFO - 'sessionrestore', 03:35:16 INFO - 'sessionrestore_no_auto_restore', 03:35:16 INFO - 'tabpaint']}, 03:35:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:35:16 INFO - 'tests': ['a11yr', 03:35:16 INFO - 'ts_paint', 03:35:16 INFO - 'tpaint', 03:35:16 INFO - 'sessionrestore', 03:35:16 INFO - 'sessionrestore_no_auto_restore', 03:35:16 INFO - 'tabpaint']}, 03:35:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:35:16 INFO - 'tests': ['tsvgx', 03:35:16 INFO - 'tsvgr_opacity', 03:35:16 INFO - 'tart', 03:35:16 INFO - 'tscrollx', 03:35:16 INFO - 'cart']}, 03:35:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:35:16 INFO - 'tsvgr_opacity', 03:35:16 INFO - 'tart', 03:35:16 INFO - 'tscrollx', 03:35:16 INFO - 'cart']}, 03:35:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:16 INFO - 'talos_options': ['--disable-e10s'], 03:35:16 INFO - 'tests': ['tp5o']}, 03:35:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:16 INFO - 'tests': ['tp5o']}, 03:35:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:16 INFO - 'talos_options': ['--disable-e10s', 03:35:16 INFO - '--xperf_path', 03:35:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:35:16 INFO - 'tests': ['tp5n']}, 03:35:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:16 INFO - 'talos_options': ['--xperf_path', 03:35:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:35:16 INFO - 'tests': ['tp5n']}}, 03:35:16 INFO - 'talos.zip': {'path': '', 03:35:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:35:16 INFO - Running post-action listener: _resource_record_post_action 03:35:16 INFO - ##### 03:35:16 INFO - ##### Finished populate-webroot step (success) 03:35:16 INFO - ##### 03:35:16 INFO - ##### 03:35:16 INFO - ##### Running create-virtualenv step. 03:35:16 INFO - ##### 03:35:16 INFO - Running pre-action listener: _resource_record_pre_action 03:35:16 INFO - Running main action method: create_virtualenv 03:35:16 INFO - Creating virtualenv /builds/slave/test/build/venv 03:35:16 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:35:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:35:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:35:17 INFO - Using real prefix '/usr' 03:35:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:35:17 INFO - Installing distribute.............................................................................................................................................................................................done. 03:35:19 INFO - Installing pip.................done. 03:35:19 INFO - Return code: 0 03:35:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:35:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f65d707df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2863020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f52e0>, '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 0x2861140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28615d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1467541942.376890-256204262', '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:35:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:35:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:35:19 INFO - Using env: {'DISPLAY': ':0', 03:35:19 INFO - 'HOME': '/home/cltbld', 03:35:19 INFO - 'LANG': 'en_US.UTF-8', 03:35:19 INFO - 'LANGUAGE': 'en_US:en', 03:35:19 INFO - 'LOGNAME': 'cltbld', 03:35:19 INFO - 'MAIL': '/var/mail/cltbld', 03:35:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:19 INFO - 'MOZ_NO_REMOTE': '1', 03:35:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:19 INFO - 'NO_EM_RESTART': '1', 03:35:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:19 INFO - 'PWD': '/builds/slave/test', 03:35:19 INFO - 'SHELL': '/bin/bash', 03:35:19 INFO - 'SHLVL': '1', 03:35:19 INFO - 'TERM': 'linux', 03:35:19 INFO - 'TMOUT': '86400', 03:35:19 INFO - 'USER': 'cltbld', 03:35:19 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467541942.376890-256204262', 03:35:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:19 INFO - '_': '/tools/buildbot/bin/python'} 03:35:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:19 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:35:19 INFO - Cleaning up... 03:35:19 INFO - Return code: 0 03:35:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:35:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f65d707df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2863020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f52e0>, '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 0x2861140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28615d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1467541942.376890-256204262', '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:35:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:35:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:35:19 INFO - Using env: {'DISPLAY': ':0', 03:35:19 INFO - 'HOME': '/home/cltbld', 03:35:19 INFO - 'LANG': 'en_US.UTF-8', 03:35:19 INFO - 'LANGUAGE': 'en_US:en', 03:35:19 INFO - 'LOGNAME': 'cltbld', 03:35:19 INFO - 'MAIL': '/var/mail/cltbld', 03:35:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:19 INFO - 'MOZ_NO_REMOTE': '1', 03:35:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:19 INFO - 'NO_EM_RESTART': '1', 03:35:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:19 INFO - 'PWD': '/builds/slave/test', 03:35:19 INFO - 'SHELL': '/bin/bash', 03:35:19 INFO - 'SHLVL': '1', 03:35:19 INFO - 'TERM': 'linux', 03:35:19 INFO - 'TMOUT': '86400', 03:35:19 INFO - 'USER': 'cltbld', 03:35:19 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467541942.376890-256204262', 03:35:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:19 INFO - '_': '/tools/buildbot/bin/python'} 03:35:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:19 INFO - Downloading/unpacking psutil>=3.1.1 03:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:35:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:35:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:35:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:35:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:35:21 INFO - Installing collected packages: psutil 03:35:21 INFO - Running setup.py install for psutil 03:35:21 INFO - building 'psutil._psutil_linux' extension 03:35:21 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:35:22 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:35:22 INFO - building 'psutil._psutil_posix' extension 03:35:22 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:35:22 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:35:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:35:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:35:22 INFO - Successfully installed psutil 03:35:22 INFO - Cleaning up... 03:35:22 INFO - Return code: 0 03:35:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:35: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:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35: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:35:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f65d707df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2863020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f52e0>, '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 0x2861140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28615d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1467541942.376890-256204262', '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:35: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:35: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 mozsystemmonitor==0.3 03:35:22 INFO - Using env: {'DISPLAY': ':0', 03:35:22 INFO - 'HOME': '/home/cltbld', 03:35:22 INFO - 'LANG': 'en_US.UTF-8', 03:35:22 INFO - 'LANGUAGE': 'en_US:en', 03:35:22 INFO - 'LOGNAME': 'cltbld', 03:35:22 INFO - 'MAIL': '/var/mail/cltbld', 03:35:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:22 INFO - 'MOZ_NO_REMOTE': '1', 03:35:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:22 INFO - 'NO_EM_RESTART': '1', 03:35:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:22 INFO - 'PWD': '/builds/slave/test', 03:35:22 INFO - 'SHELL': '/bin/bash', 03:35:22 INFO - 'SHLVL': '1', 03:35:22 INFO - 'TERM': 'linux', 03:35:22 INFO - 'TMOUT': '86400', 03:35:22 INFO - 'USER': 'cltbld', 03:35:22 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467541942.376890-256204262', 03:35:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:22 INFO - '_': '/tools/buildbot/bin/python'} 03:35:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:35: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:35: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:35: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:35: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:35: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:35: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:35:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:35:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:35:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:35:24 INFO - Installing collected packages: mozsystemmonitor 03:35:24 INFO - Running setup.py install for mozsystemmonitor 03:35:24 INFO - Successfully installed mozsystemmonitor 03:35:24 INFO - Cleaning up... 03:35:24 INFO - Return code: 0 03:35:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:35: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:35:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35: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:35:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35: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', '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 0x7f65d707df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2863020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f52e0>, '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 0x2861140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28615d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1467541942.376890-256204262', '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:35: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:35: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 jsonschema==2.5.1 03:35:24 INFO - Using env: {'DISPLAY': ':0', 03:35:24 INFO - 'HOME': '/home/cltbld', 03:35:24 INFO - 'LANG': 'en_US.UTF-8', 03:35:24 INFO - 'LANGUAGE': 'en_US:en', 03:35:24 INFO - 'LOGNAME': 'cltbld', 03:35:24 INFO - 'MAIL': '/var/mail/cltbld', 03:35:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:24 INFO - 'MOZ_NO_REMOTE': '1', 03:35:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:24 INFO - 'NO_EM_RESTART': '1', 03:35:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:24 INFO - 'PWD': '/builds/slave/test', 03:35:24 INFO - 'SHELL': '/bin/bash', 03:35:24 INFO - 'SHLVL': '1', 03:35:24 INFO - 'TERM': 'linux', 03:35:24 INFO - 'TMOUT': '86400', 03:35:24 INFO - 'USER': 'cltbld', 03:35:24 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467541942.376890-256204262', 03:35:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:24 INFO - '_': '/tools/buildbot/bin/python'} 03:35:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:24 INFO - Downloading/unpacking jsonschema==2.5.1 03:35:24 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:35:24 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:35:24 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:35:24 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:35:24 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:35:24 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:35:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:35:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:35:26 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:35:26 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:35:26 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:35:26 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:35:26 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:35:26 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:35:27 INFO - Downloading functools32-3.2.3-2.tar.gz 03:35:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:35:27 INFO - warning: no files found matching '*.txt' 03:35:27 INFO - no previously-included directories found matching 'build' 03:35:27 INFO - no previously-included directories found matching 'dist' 03:35:27 INFO - no previously-included directories found matching '.git*' 03:35:27 INFO - Installing collected packages: jsonschema, functools32 03:35:27 INFO - Running setup.py install for functools32 03:35:27 INFO - warning: no files found matching '*.txt' 03:35:27 INFO - no previously-included directories found matching 'build' 03:35:27 INFO - no previously-included directories found matching 'dist' 03:35:27 INFO - no previously-included directories found matching '.git*' 03:35:27 INFO - Successfully installed jsonschema functools32 03:35:27 INFO - Cleaning up... 03:35:27 INFO - Return code: 0 03:35:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:35: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:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35: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:35:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35: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', '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 0x7f65d707df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2863020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f52e0>, '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 0x2861140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28615d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1467541942.376890-256204262', '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:35: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:35: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 blobuploader==1.2.4 03:35:27 INFO - Using env: {'DISPLAY': ':0', 03:35:27 INFO - 'HOME': '/home/cltbld', 03:35:27 INFO - 'LANG': 'en_US.UTF-8', 03:35:27 INFO - 'LANGUAGE': 'en_US:en', 03:35:27 INFO - 'LOGNAME': 'cltbld', 03:35:27 INFO - 'MAIL': '/var/mail/cltbld', 03:35:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:27 INFO - 'MOZ_NO_REMOTE': '1', 03:35:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:27 INFO - 'NO_EM_RESTART': '1', 03:35:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:27 INFO - 'PWD': '/builds/slave/test', 03:35:27 INFO - 'SHELL': '/bin/bash', 03:35:27 INFO - 'SHLVL': '1', 03:35:27 INFO - 'TERM': 'linux', 03:35:27 INFO - 'TMOUT': '86400', 03:35:27 INFO - 'USER': 'cltbld', 03:35:27 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467541942.376890-256204262', 03:35:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:27 INFO - '_': '/tools/buildbot/bin/python'} 03:35:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:27 INFO - Downloading/unpacking blobuploader==1.2.4 03:35: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:35: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:35: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:35: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:35: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:35: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:35:29 INFO - Downloading blobuploader-1.2.4.tar.gz 03:35:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:35:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:35: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:35: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:35: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:35: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:35: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:35: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:35:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:35:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:35: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:35: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:35: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:35: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:35: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:35: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:35:30 INFO - Downloading docopt-0.6.1.tar.gz 03:35:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:35:30 INFO - Installing collected packages: blobuploader, requests, docopt 03:35:30 INFO - Running setup.py install for blobuploader 03:35:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:35:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:35:30 INFO - Running setup.py install for requests 03:35:30 INFO - Running setup.py install for docopt 03:35:30 INFO - Successfully installed blobuploader requests docopt 03:35:30 INFO - Cleaning up... 03:35:30 INFO - Return code: 0 03:35:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:35:30 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:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:30 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:35:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:30 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 0x7f65d707df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2863020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f52e0>, '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 0x2861140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28615d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1467541942.376890-256204262', '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:35:30 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:35:30 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:35:30 INFO - Using env: {'DISPLAY': ':0', 03:35:30 INFO - 'HOME': '/home/cltbld', 03:35:30 INFO - 'LANG': 'en_US.UTF-8', 03:35:30 INFO - 'LANGUAGE': 'en_US:en', 03:35:30 INFO - 'LOGNAME': 'cltbld', 03:35:30 INFO - 'MAIL': '/var/mail/cltbld', 03:35:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:30 INFO - 'MOZ_NO_REMOTE': '1', 03:35:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:30 INFO - 'NO_EM_RESTART': '1', 03:35:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:30 INFO - 'PWD': '/builds/slave/test', 03:35:30 INFO - 'SHELL': '/bin/bash', 03:35:30 INFO - 'SHLVL': '1', 03:35:30 INFO - 'TERM': 'linux', 03:35:30 INFO - 'TMOUT': '86400', 03:35:30 INFO - 'USER': 'cltbld', 03:35:30 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467541942.376890-256204262', 03:35:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:30 INFO - '_': '/tools/buildbot/bin/python'} 03:35:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:35:30 INFO - Running setup.py (path:/tmp/pip-oFWxHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:35:31 INFO - Running setup.py (path:/tmp/pip-fxz8UB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:35:31 INFO - Running setup.py (path:/tmp/pip-s7Mu_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:35:31 INFO - Running setup.py (path:/tmp/pip-sjphbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:35:31 INFO - Running setup.py (path:/tmp/pip-nSThe8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:35:31 INFO - Running setup.py (path:/tmp/pip-Q_REpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:35:31 INFO - Running setup.py (path:/tmp/pip-p8rTf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:35:31 INFO - Running setup.py (path:/tmp/pip-ISsR1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:35:31 INFO - Running setup.py (path:/tmp/pip-Jck4cD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:35:31 INFO - Running setup.py (path:/tmp/pip-vp1Maa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:35:31 INFO - Running setup.py (path:/tmp/pip-qxLD3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:35:31 INFO - Running setup.py (path:/tmp/pip-pU_FwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:35:31 INFO - Running setup.py (path:/tmp/pip-SaQ5C9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:35:31 INFO - Running setup.py (path:/tmp/pip-amQ542-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:31 INFO - Running setup.py (path:/tmp/pip-hqhZH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:35:32 INFO - Running setup.py (path:/tmp/pip-Hh3j1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:35:32 INFO - Running setup.py (path:/tmp/pip-To57VS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:35:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:35:32 INFO - Running setup.py install for manifestparser 03:35:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:35:32 INFO - Running setup.py install for mozcrash 03:35:32 INFO - Running setup.py install for mozdebug 03:35:32 INFO - Running setup.py install for mozdevice 03:35:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:35:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:35:32 INFO - Running setup.py install for mozfile 03:35:32 INFO - Running setup.py install for mozhttpd 03:35:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:35:32 INFO - Running setup.py install for mozinfo 03:35:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:35:32 INFO - Running setup.py install for mozInstall 03:35:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:35:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:35:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:35:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:35:32 INFO - Running setup.py install for mozleak 03:35:33 INFO - Running setup.py install for mozlog 03:35:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:35:33 INFO - Running setup.py install for moznetwork 03:35:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:35:33 INFO - Running setup.py install for mozprocess 03:35:33 INFO - Running setup.py install for mozprofile 03:35:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:35:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:35:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:35:33 INFO - Running setup.py install for mozrunner 03:35:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:35:33 INFO - Running setup.py install for mozscreenshot 03:35:33 INFO - Running setup.py install for moztest 03:35:33 INFO - Running setup.py install for mozversion 03:35:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:35:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:35:33 INFO - Cleaning up... 03:35:33 INFO - Return code: 0 03:35:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:35: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:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35: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:35:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:33 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 0x7f65d707df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2863020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f52e0>, '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 0x2861140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28615d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1467541942.376890-256204262', '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:35:33 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:35:33 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:35:33 INFO - Using env: {'DISPLAY': ':0', 03:35:33 INFO - 'HOME': '/home/cltbld', 03:35:33 INFO - 'LANG': 'en_US.UTF-8', 03:35:33 INFO - 'LANGUAGE': 'en_US:en', 03:35:33 INFO - 'LOGNAME': 'cltbld', 03:35:33 INFO - 'MAIL': '/var/mail/cltbld', 03:35:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:33 INFO - 'MOZ_NO_REMOTE': '1', 03:35:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:33 INFO - 'NO_EM_RESTART': '1', 03:35:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:33 INFO - 'PWD': '/builds/slave/test', 03:35:33 INFO - 'SHELL': '/bin/bash', 03:35:33 INFO - 'SHLVL': '1', 03:35:33 INFO - 'TERM': 'linux', 03:35:33 INFO - 'TMOUT': '86400', 03:35:33 INFO - 'USER': 'cltbld', 03:35:33 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467541942.376890-256204262', 03:35:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:33 INFO - '_': '/tools/buildbot/bin/python'} 03:35:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:35:34 INFO - Running setup.py (path:/tmp/pip-6au4iL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:35:34 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:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:35:34 INFO - Running setup.py (path:/tmp/pip-S2SG7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:35:34 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:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:35:34 INFO - Running setup.py (path:/tmp/pip-qj2R4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:35:34 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:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:35:34 INFO - Running setup.py (path:/tmp/pip-wQZlgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:35:34 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:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:35:34 INFO - Running setup.py (path:/tmp/pip-JGvILl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:35:34 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:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:35:34 INFO - Running setup.py (path:/tmp/pip-Gw09Bg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:35:34 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:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:35:34 INFO - Running setup.py (path:/tmp/pip-bH4kgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:35:34 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:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:35:34 INFO - Running setup.py (path:/tmp/pip-scuS5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:35:34 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:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:35:34 INFO - Running setup.py (path:/tmp/pip-7SyeNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:35:34 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:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:35:34 INFO - Running setup.py (path:/tmp/pip-hkKj8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:35:34 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:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:35:34 INFO - Running setup.py (path:/tmp/pip-wbYV1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:35:34 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:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:35:34 INFO - Running setup.py (path:/tmp/pip-tc5N6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:35:35 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:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:35:35 INFO - Running setup.py (path:/tmp/pip-jMUUUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:35:35 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:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:35:35 INFO - Running setup.py (path:/tmp/pip-aXvaUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:35:35 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:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:35 INFO - Running setup.py (path:/tmp/pip-OzgHW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:35:35 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:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:35:35 INFO - Running setup.py (path:/tmp/pip-D7dbHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:35:35 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:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:35:35 INFO - Running setup.py (path:/tmp/pip-ZUOE67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:35:35 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:35:35 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:35:35 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:35:35 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:35:35 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:35:35 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:35:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:35:35 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:35:35 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:35:35 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:35:35 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:35:35 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:35:35 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:35:37 INFO - Downloading blessings-1.6.tar.gz 03:35:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:35:37 INFO - Installing collected packages: blessings 03:35:37 INFO - Running setup.py install for blessings 03:35:37 INFO - Successfully installed blessings 03:35:37 INFO - Cleaning up... 03:35:37 INFO - Return code: 0 03:35:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:35:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:35:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:35:37 INFO - Reading from file tmpfile_stdout 03:35:37 INFO - Current package versions: 03:35:37 INFO - argparse == 1.2.1 03:35:37 INFO - blessings == 1.6 03:35:37 INFO - blobuploader == 1.2.4 03:35:37 INFO - docopt == 0.6.1 03:35:37 INFO - functools32 == 3.2.3-2 03:35:37 INFO - jsonschema == 2.5.1 03:35:37 INFO - manifestparser == 1.1 03:35:37 INFO - mozInstall == 1.12 03:35:37 INFO - mozcrash == 0.17 03:35:37 INFO - mozdebug == 0.1 03:35:37 INFO - mozdevice == 0.48 03:35:37 INFO - mozfile == 1.2 03:35:37 INFO - mozhttpd == 0.7 03:35:37 INFO - mozinfo == 0.9 03:35:37 INFO - mozleak == 0.1 03:35:37 INFO - mozlog == 3.2 03:35:37 INFO - moznetwork == 0.27 03:35:37 INFO - mozprocess == 0.22 03:35:37 INFO - mozprofile == 0.28 03:35:37 INFO - mozrunner == 6.11 03:35:37 INFO - mozscreenshot == 0.1 03:35:37 INFO - mozsystemmonitor == 0.3 03:35:37 INFO - moztest == 0.7 03:35:37 INFO - mozversion == 1.4 03:35:37 INFO - psutil == 3.1.1 03:35:37 INFO - requests == 1.2.3 03:35:37 INFO - wsgiref == 0.1.2 03:35:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:35:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:37 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 0x7f65d707df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2863020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f52e0>, '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 0x2861140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28615d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1467541942.376890-256204262', '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:35:37 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:35:37 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:35:37 INFO - Using env: {'DISPLAY': ':0', 03:35:37 INFO - 'HOME': '/home/cltbld', 03:35:37 INFO - 'LANG': 'en_US.UTF-8', 03:35:37 INFO - 'LANGUAGE': 'en_US:en', 03:35:37 INFO - 'LOGNAME': 'cltbld', 03:35:37 INFO - 'MAIL': '/var/mail/cltbld', 03:35:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:37 INFO - 'MOZ_NO_REMOTE': '1', 03:35:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:37 INFO - 'NO_EM_RESTART': '1', 03:35:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:37 INFO - 'PWD': '/builds/slave/test', 03:35:37 INFO - 'SHELL': '/bin/bash', 03:35:37 INFO - 'SHLVL': '1', 03:35:37 INFO - 'TERM': 'linux', 03:35:37 INFO - 'TMOUT': '86400', 03:35:37 INFO - 'USER': 'cltbld', 03:35:37 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467541942.376890-256204262', 03:35:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:37 INFO - '_': '/tools/buildbot/bin/python'} 03:35:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:37 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:35:37 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:35:37 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:35:37 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:35:37 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:35:37 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:35:37 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:35:37 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:35:37 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:35:37 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:35:37 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:35:37 INFO - Cleaning up... 03:35:38 INFO - Return code: 0 03:35:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:38 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 0x7f65d707df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2863020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f52e0>, '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 0x2861140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28615d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1467541942.376890-256204262', '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:35:38 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:35:38 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:35:38 INFO - Using env: {'DISPLAY': ':0', 03:35:38 INFO - 'HOME': '/home/cltbld', 03:35:38 INFO - 'LANG': 'en_US.UTF-8', 03:35:38 INFO - 'LANGUAGE': 'en_US:en', 03:35:38 INFO - 'LOGNAME': 'cltbld', 03:35:38 INFO - 'MAIL': '/var/mail/cltbld', 03:35:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:38 INFO - 'MOZ_NO_REMOTE': '1', 03:35:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:38 INFO - 'NO_EM_RESTART': '1', 03:35:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:38 INFO - 'PWD': '/builds/slave/test', 03:35:38 INFO - 'SHELL': '/bin/bash', 03:35:38 INFO - 'SHLVL': '1', 03:35:38 INFO - 'TERM': 'linux', 03:35:38 INFO - 'TMOUT': '86400', 03:35:38 INFO - 'USER': 'cltbld', 03:35:38 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467541942.376890-256204262', 03:35:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:38 INFO - '_': '/tools/buildbot/bin/python'} 03:35:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:35:38 INFO - Cleaning up... 03:35:38 INFO - Return code: 0 03:35:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:35:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:35:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:35:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:35:38 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 0x7f65d707df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2863020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f52e0>, '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 0x2861140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28615d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1467541942.376890-256204262', '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:35:38 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:35:38 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:35:38 INFO - Using env: {'DISPLAY': ':0', 03:35:38 INFO - 'HOME': '/home/cltbld', 03:35:38 INFO - 'LANG': 'en_US.UTF-8', 03:35:38 INFO - 'LANGUAGE': 'en_US:en', 03:35:38 INFO - 'LOGNAME': 'cltbld', 03:35:38 INFO - 'MAIL': '/var/mail/cltbld', 03:35:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:38 INFO - 'MOZ_NO_REMOTE': '1', 03:35:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:38 INFO - 'NO_EM_RESTART': '1', 03:35:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:38 INFO - 'PWD': '/builds/slave/test', 03:35:38 INFO - 'SHELL': '/bin/bash', 03:35:38 INFO - 'SHLVL': '1', 03:35:38 INFO - 'TERM': 'linux', 03:35:38 INFO - 'TMOUT': '86400', 03:35:38 INFO - 'USER': 'cltbld', 03:35:38 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467541942.376890-256204262', 03:35:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:38 INFO - '_': '/tools/buildbot/bin/python'} 03:35:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:35:38 INFO - Downloading/unpacking flake8 03:35:38 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:35:38 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:35:38 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:35:38 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:35:38 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:35:38 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:35:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:35:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:35: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:35: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:35: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:35: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:35: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:35: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:35:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:35:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:35: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:35: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:35: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:35: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:35: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:35: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:35:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:35: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:35: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:35: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:35: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:35: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:35: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:35:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:35:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:35:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:35:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:35:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:35:41 INFO - no previously-included directories found matching 'docs/_build' 03:35:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:35:41 INFO - Running setup.py install for pep8 03:35:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:35:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:35:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:35:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:35:41 INFO - no previously-included directories found matching 'docs/_build' 03:35:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:35:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:35:41 INFO - Cleaning up... 03:35:41 INFO - Return code: 0 03:35:41 INFO - Running post-action listener: _resource_record_post_action 03:35:41 INFO - Running post-action listener: _start_resource_monitoring 03:35:41 INFO - Starting resource monitoring. 03:35:41 INFO - ##### 03:35:41 INFO - ##### Finished create-virtualenv step (success) 03:35:41 INFO - ##### 03:35:41 INFO - ##### 03:35:41 INFO - ##### Running install step. 03:35:41 INFO - ##### 03:35:41 INFO - Running pre-action listener: _resource_record_pre_action 03:35:41 INFO - Running main action method: install 03:35:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:35:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:35:41 INFO - Reading from file tmpfile_stdout 03:35:41 INFO - Detecting whether we're running mozinstall >=1.0... 03:35:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:35:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:35:41 INFO - Reading from file tmpfile_stdout 03:35:41 INFO - Output received: 03:35:41 INFO - Usage: mozinstall [options] installer 03:35:41 INFO - Options: 03:35:41 INFO - -h, --help show this help message and exit 03:35:41 INFO - -d DEST, --destination=DEST 03:35:41 INFO - Directory to install application into. [default: 03:35:41 INFO - "/builds/slave/test"] 03:35:41 INFO - --app=APP Application being installed. [default: firefox] 03:35:41 INFO - mkdir: /builds/slave/test/build/application 03:35:41 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:35:41 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:35:57 INFO - Reading from file tmpfile_stdout 03:35:57 INFO - Output received: 03:35:57 INFO - /builds/slave/test/build/application/firefox/firefox 03:35:57 INFO - Running post-action listener: _resource_record_post_action 03:35:57 INFO - ##### 03:35:57 INFO - ##### Finished install step (success) 03:35:57 INFO - ##### 03:35:57 INFO - ##### 03:35:57 INFO - ##### Running run-tests step. 03:35:57 INFO - ##### 03:35:57 INFO - Running pre-action listener: _resource_record_pre_action 03:35:57 INFO - Running main action method: run_tests 03:35:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:35:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:35:57 INFO - Python 2.7.3 03:35:57 INFO - Return code: 0 03:35:57 INFO - grabbing minidump binary from tooltool 03:35:57 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:35:57 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 0x28f52e0>, '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 0x2861140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28615d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:35:57 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:35:57 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:35:57 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:35:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:35:57 INFO - Return code: 0 03:35:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:35:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:35:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:35:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:35:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:35:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:35:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:35:58 INFO - Return code: 0 03:35:58 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/ByaYG22TSOi3QRl31uNTTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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:35:58 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/ByaYG22TSOi3QRl31uNTTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --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:35:58 INFO - Using env: {'DISPLAY': ':0', 03:35:58 INFO - 'HOME': '/home/cltbld', 03:35:58 INFO - 'LANG': 'en_US.UTF-8', 03:35:58 INFO - 'LANGUAGE': 'en_US:en', 03:35:58 INFO - 'LOGNAME': 'cltbld', 03:35:58 INFO - 'MAIL': '/var/mail/cltbld', 03:35:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:35:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:35:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:58 INFO - 'MOZ_NO_REMOTE': '1', 03:35:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:35:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:35:58 INFO - 'NO_EM_RESTART': '1', 03:35:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:35:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:58 INFO - 'PWD': '/builds/slave/test', 03:35:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:35:58 INFO - 'SHELL': '/bin/bash', 03:35:58 INFO - 'SHLVL': '1', 03:35:58 INFO - 'TERM': 'linux', 03:35:58 INFO - 'TMOUT': '86400', 03:35:58 INFO - 'USER': 'cltbld', 03:35:58 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467541942.376890-256204262', 03:35:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:58 INFO - '_': '/tools/buildbot/bin/python'} 03:35:58 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/ByaYG22TSOi3QRl31uNTTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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:35:58 INFO - mozversion application_buildid: 20160703010121 03:35:58 INFO - mozversion application_changeset: 1aa23cad1885319a42c69e0cc445a919abd24a14 03:35:58 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:35:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:35:58 INFO - mozversion application_name: Firefox 03:35:58 INFO - mozversion application_remotingname: firefox-dev 03:35:58 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:35:58 INFO - mozversion application_vendor: Mozilla 03:35:58 INFO - mozversion application_version: 49.0a2 03:35:58 INFO - mozversion platform_buildid: 20160703010121 03:35:58 INFO - mozversion platform_changeset: 1aa23cad1885319a42c69e0cc445a919abd24a14 03:35:58 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:35:58 INFO - mozversion platform_version: 49.0a2 03:35:58 INFO - using testdate: 1467542158 03:35:58 INFO - actual date: 1467542158 03:35:58 INFO - starting webserver on 'localhost:42147' 03:35:58 INFO - SUITE-START | Running 2 tests 03:35:58 INFO - TEST-START | dromaeo_css 03:35:58 INFO - operating with platform_type : linux_ 03:35:58 INFO - Initialising browser for dromaeo_css test... 03:35:58 INFO - TEST-INFO | started process 22547 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6QzhAX/profile http://localhost:42147/getInfo.html) 03:36:02 INFO - PROCESS | 22547 | __metrics Screen width/height:1600/1200 03:36:02 INFO - PROCESS | 22547 | colorDepth:24 03:36:02 INFO - PROCESS | 22547 | Browser inner width/height: 1024/697 03:36:02 INFO - PROCESS | 22547 | __metrics 03:36:03 ERROR - PROCESS | 22547 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:36:04 INFO - TEST-INFO | 22547: exit 0 03:36:04 INFO - Browser initialized. 03:36:04 INFO - Running cycle 1/1 for dromaeo_css test... 03:36:04 INFO - TEST-INFO | started process 22640 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6QzhAX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:36:16 INFO - PROCESS | 22640 | RSS: Main: 145522688 03:36:16 INFO - PROCESS | 22640 | 03:37:07 INFO - PROCESS | 22640 | 1467542227471 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] 03:39:15 INFO - PROCESS | 22640 | Cycle 1(1): loaded http://localhost:42147/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42147/tests/dromaeo/cssquery-ext.html) 03:39:16 INFO - PROCESS | 22640 | RSS: Main: 253468672 03:39:16 INFO - PROCESS | 22640 | 03:42:19 INFO - PROCESS | 22640 | Cycle 1(1): loaded http://localhost:42147/tests/dromaeo/cssquery-ext.html (next: http://localhost:42147/tests/dromaeo/cssquery-jquery.html) 03:42:19 INFO - PROCESS | 22640 | RSS: Main: 228409344 03:42:19 INFO - PROCESS | 22640 | 03:45:21 INFO - PROCESS | 22640 | Cycle 1(1): loaded http://localhost:42147/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42147/tests/dromaeo/cssquery-mootools.html) 03:45:22 INFO - PROCESS | 22640 | RSS: Main: 235388928 03:45:22 INFO - PROCESS | 22640 | 03:48:24 INFO - PROCESS | 22640 | Cycle 1(1): loaded http://localhost:42147/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42147/tests/dromaeo/cssquery-prototype.html) 03:48:24 INFO - PROCESS | 22640 | RSS: Main: 224247808 03:48:24 INFO - PROCESS | 22640 | 03:51:27 INFO - PROCESS | 22640 | Cycle 1(1): loaded http://localhost:42147/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42147/tests/dromaeo/cssquery-yui.html) 03:51:27 INFO - PROCESS | 22640 | RSS: Main: 210038784 03:51:27 INFO - PROCESS | 22640 | 03:54:30 INFO - PROCESS | 22640 | Cycle 1(1): loaded http://localhost:42147/tests/dromaeo/cssquery-yui.html (next: http://localhost:42147/tests/dromaeo/cssquery-dojo.html) 03:54:30 INFO - PROCESS | 22640 | RSS: Main: 244981760 03:54:30 INFO - PROCESS | 22640 | 03:54:30 INFO - PROCESS | 22640 | __start_tp_report 03:54:30 INFO - PROCESS | 22640 | _x_x_mozilla_page_load 03:54:30 INFO - PROCESS | 22640 | _x_x_mozilla_page_load_details 03:54:30 INFO - PROCESS | 22640 | |i|pagename|runs| 03:54:30 INFO - PROCESS | 22640 | |0;dojo.html;3251.691089346513;3275.377678241134;3301.867925282989;3326.517654940032;3345.0466617014154;5390.973045134779;5485.725713714313;5526.06056970315;5535.972320138399;5541.27963364763;5493.752781124849;5541.612087153891;5546.334439867212;5548;5573.860653483665;4960.503949605047;4998.300237966688;5016.598672106223;5058.747062646871;5087.974560127194;4903.950960490385;5040.218766091243;5070.5183007614405;5077.238414237857;5083.288339632454;5006.249062640597;5028.069807085682;5059.696418214919;5092.821751238707;5157.174852023677;5149.922751158736;5164.535191832715;5177.275181474596;5178.378594568639;5188.662736922088;4889.144399730033;4968.726720030397;4995;5057.342545469102;5068.923966140511;5353.625246232727;5400.756965936543;5436.755346009439;5464.398916119224;5499.972500137514;5952.136940143655;5998.040313549855;6002.009668404708;6003.039513677791;6006.519478441758;5885.293764748215;5939.910901336483;5943.940560594425;6000.8499787505225;6025.969870150665;5597.132444471114;5598.076317407623;5601.495865372095;5609.3268807742925;5622.606417550732;5799.594028418054;6066.827797573087;6086.817395478054;6089.086637004485;6092.878142437126;5763.394843541368;5827.388124246978;5837.854053648693;5926.466618004314;5936.554758393051;5991.850203744942;5996.790112346047;6023.548233882389;6026.126211699367;6035.8792824143275;5703.800366987219;5837.445442682938;5959.612625179436;5962.2249107615735;5972.820815375546;5801.129830525455;5913.881722365529;5929.0513517836935;5929.940700593025;5970.582059255898;4515.209838278354;4522.389477420572;4526.072155208174;4530.116627257719;4548.7725613719185;3953.327934251184;3977.3039718049226;4004.01901534126;4078.938815917764;4105.4252404663375;5586.888262234733;5587.664740115606;5610.915836262459;5613.719314034363;5638.802641907513;5952.8809423812145;5974.462298393166;5975;5978.760849566055;6007.669578173155;5373.435789242151;5522.502974732293;5554.333479982347;5588.0779671354585;5606.775728970877;5113.437521872591;5142.100132476801;5147.588192944556;5148.099082660594;5150.021495915764;6174.938250617436;6182.443580077815;6201.937980620136;6206.0690896365;6211.378862113753;5756.165356023437;5885.529157667291;5927.347991720993;5937.317208521075;5966.403359664172;6119.35746746603;6128.816135515942;6129.570930035033;6131.233595800525;6131.478824299985;5649.37856835756;5820.185174075717;5825.737841797214;5852.473277405054;5869.647821130746;5874.735636896436;5907.4683278505145;5929.970350148222;5976.282846058501;5989.1914591529585;5782.10377391505;5788.044972579645;5832.387599302012;5839.620424672383;5852.209951656472;5640.605157638925;5698.857528561819;5781.971090144522;5842.766289348378;5856.765729370948;5604.663720176803;5659.773609055592;5696.743646535999;5712.828615141552;5744.368119506935;5831.1836342912875;5846.473817356458;5865.648061116347;5882.588218824641;5883.382244864228;5585.776568937359;5676.602637815313;5701.344345400332;5715.628484148517;5726.198332233407 03:54:30 INFO - PROCESS | 22640 | |1;ext.html;592.4726992976252;633.2116514938899;636.0522820996715;647.8348021254579;651.042966838747;32749;45090.54909450904;45607.54392456074;45653.31520027198;45726.54273457264;47649.28526072103;47829.76085119569;47890;47931.76034119833;48031.27953080706;8299.83400331993;9010.279177665803;9166.40418372807;9166.770830729218;10890.61882834101;10661.680149595524;10787.352758834495;11125.499352529116;11128.944355278212;11134.10927125832;11184.552617895275;11245.60640377587;11258.211925165242;11259.21185517014;11261.662150135468;8280.130586288444;10729.195310351755;10993.230473866832;11022.173336999676;11042.834357484644;10705.678829635046;10780.676579702622;10781.838272425919;10789;10790.51442685081;45535.77232113852;45593.316100258526;45836.54163458356;45941.31088033682;46033.76983115063;3692.7968961707097;3818.389057750774;3949.5063117110362;3951.8616848410165;4465.213904537494;35513.46729799055;35778.64221357779;35791;35816.462753058724;35825.64174358275;4579.592605628552;4585.449746030465;4657.138429390574;4668.649851261169;4700.976495117537;376065;378679;380074.9999999972;382252;382930;68579.65710171417;68757.31242687609;69070.65464672644;69086;69134.65432672805;40586;41719.1656166875;41748.79125604413;43585.34621980673;43655;16712.415065472895;16989.23548440323;17058.658826823394;17068;17072.146392680315;11290.491927863266;12700;12853.16454430459;12899.35503224835;13092.279924604049;21984.45038874041;22323.330300091024;22330.320361556718;22342.43602947778;22350.888245558668;7690;7697.576633285111;7867.685292588347;7890.8816367754525;7972.083210430758;817.7464985854405;844.1980118887082;953.2278854128178;991.3902949685892;1018.6943916825071;33567.49648755271;33881.32237355288;34014.659853401645;34247.65752342495;34573.654263457545;1081.3836113415277;1096.6107032003683;1098.9395583242838;1120.8542889424323;1127.115214556569;16522.173891305385;16679.24943377551;16714.6657066858;16809.579760506083;17192.914035429993;643807;645744;647728;650364;650452;59937.400625993185;59955.70022149861;60322.698386508666;60423;60532;1266.7086570088748;1362.863713628649;1380.3167432120963;1394.8326200855963;1409.5489443378226;30817.537736934413;33336.49995250122;33944;34299.14252143716;34384.312313753086;52274;52658.21012684736;52728.47271527236;52805.207921880436;52806.2079068822;485355;490023;490364;490860;491037;30320.39359212759;30468.695313046584;31480.685193148693;31639.367212656078;32795.836020820694;50670.74664626653;52097.218541722665;52332.73833630807;52709.7364513175;52736.73631631817;43295.108359133126;43785.343219852366;44045.33931991087;44181.55818441774;44244.778776105915;43432.565674344114;43749.34375984299;44096.11807763891;44171.77914110409;44887.55112448834;40035.3994690074;43257.35113973356;43964.120717586105;44037;44272;38171.23657526779;38775;38963.610363896;39161.314507059855;39698;29086;29122.12633620995;29128.56307155352;29545.704542954296;29606.703932960394 03:54:30 INFO - PROCESS | 22640 | |2;jquery.html;401.37385678341786;410.9301418758812;415.4693072049303;421.5426262505182;427.56174920706275;18746;19644.607107857835;19839.40481785547;20191.899040504813;20340.89829550852;19458.221671133175;19759.901200493976;20209.956785304024;20370.38888833334;20396.59206815863;5707.286589176363;6040.848978775522;6048.425399587032;6049.153118563405;6049.727762250687;5731.197632331477;5913.113033045035;5982.132590774335;5982.8504287392725;6030.788922387717;5955.464008239258;5988;5989.730462129193;6010.27876654802;6010.609310394832;5730.885382292352;5980.73086711099;5981.312149102865;5982.491488223506;5990.101484777275;5340.225667278261;5345.4387289334445;5352.2239275305255;5359.303290572239;5379.1393377059485;23446.765532344627;23520.176793812305;23630.527389452287;24210.878945605335;24291.271261862174;2268.7408488288993;2303.7120359955006;2333.5099629077913;2345.6598793175067;2345.7067866516686;14855.77716334245;15187.696246075016;15346.386144554204;15478.767818482731;15536.145511996836;2028.4117605894273;2046.8567200295986;2091.0903756865814;2105.315772373969;2112.4718820294925;77903;79469.20530794676;80358.59820700917;80409;82021.58989205016;10867.130629549618;11018.614348497764;11169.497372618252;11228.382438965935;11326.093912486982;15713.68572628541;15822.60443488922;15837.128957907426;15857.127857967691;16025.519234422753;8217.671293148327;8480.703175388831;8529.829403411897;8543.786405339917;8601.096884827128;8051.63767630458;8097.878531822027;8111.553864537507;8199.754007379788;8332.916670833214;6924.93075069253;7005.984132300788;7063.752768653175;7077.7168913242895;7109.360157585842;1838.7517685112607;1943.416974907522;1960.9901950490157;2005.1478121798177;2030.2691031228746;927.332320729074;1002.5137808163036;1010.7018429563296;1061.830107182847;1087.5377964365114;17916.462506124837;20139.79860201379;20373.286934957207;20403;20725.170993160405;996.4419924842111;1049.2602715085845;1071.2501249125644;1075.0969185883896;1125.5441546173813;10503;11613.825792613117;11639.301641901513;11778.293302401884;11816.76366472683;448613;457288;459535;460082;465581;54248.728756355966;81742.59128704437;86617.5669121663;87093;88217;1061.363182090755;1079.3577821196532;1084.9945750271356;1097.1716354152563;1110.0509064749524;18086.728699069263;18245.54386140357;18265;18295.26818927228;18391;37475.81262093672;38496.422553662276;39439.408408874464;39932.2013559733;39958.800205998785;53366.46633533615;53428.465715343904;53476.331360946184;53644.46355536551;53754.193687093946;9143.26853851677;9226.169644732006;9283.67507137274;9342.673006445013;9464.905350946403;14384.856151438351;14405.207713575854;14455.85544144545;14466.927665362027;14611.269436528344;12384.938075309567;12540.24758514492;12582.370881455707;12759.808602870778;12841.550545731228;12133.696657583278;12219.144659874079;12314;12863.356832158168;13063.085584009408;6092.939070609415;12504.624861254177;12771.87228127744;13003.479860805463;13023.348832558524;9205.861912071457;9299.256059515357;9344.784692314946;9347.112024357675;9490.003549627467;12535.373231338579;12554.937225313815;12580.056495762672;12697.047721421115;12714.554990575285 03:54:30 INFO - PROCESS | 22640 | |3;mootools.html;1265.2155663488638;1494.9327280272382;1535.0099186025013;1656.8177500474947;1859.5908900041986;9053.773655658604;9305.255579553637;9374.484403357812;9610.663626773065;9642.469664168468;9424.623015079389;9632.662856800014;9637.71086867395;9649.083337082984;9652.517374131283;2112.71478350423;2412.6984126984125;2419.903203871843;2449.7427770084064;2489.7634724701124;2504.2987963370288;2514.8742562871876;2520.080170737686;2522.646829443879;2522.962155567668;2381.38084098134;2442.2917353967327;2444.1934161726585;2445.3764290105996;2447.632855071736;2107.051826677993;2378.5361854438393;2405.855648661086;2434.8782560871887;2444.8655323957173;2392.676988606533;2403.723571789249;2406.217979156781;2411.9517609647883;2427.1262345555588;9546.474943878153;9550.140487356102;9575.61697532098;9625.422474651543;9629.277804164716;5404.054290499147;5540.307461567304;5543.362513310981;5553.194786755897;5554.1391084381985;3426.3318652862704;3500.562429696288;3559.181388280684;3560.608333083359;3563.875264365761;1070.8554345163382;1092.6121226964392;1108.5898217659437;1120.4229821641861;1145.9885401145966;13766.793498097437;13861.722765544733;13871.583852484442;13873.236971966538;13880.51418200358;4746.905061898743;4767.928481072787;4788.569028787426;4819.59033482151;4831.050992240229;11308.660740177807;11398.373089480157;11413.60052398162;11413.657590272305;11421.200515963968;5520.723963801794;5525.4474552544425;5528.778848846001;5531.695756733418;5538.723063846872;4476.910461790746;5012.573931215815;5134.948650513447;5145.845624631267;5194.065068287745;4266.957330426718;4294;4343.978280108579;4348.412964249786;4427.822887084545;1257.0948916779903;1270.5362542671858;1286.6204469681466;1288.6842723532795;1300.3498250874563;897.8069715011304;966.4153187321709;985.5072463768116;1007.536533194724;1031.8761748590218;6355.872882542416;6494.318096599884;6536.379043990813;6553.279139294674;6615.735370585123;437.3046855499771;450.40771385627795;458.30337886413133;460.64530311659837;462.81256091283086;4340.826366945287;4438.822447102144;4531.8187272509385;4574.5425457453985;4604.953950460453;11640;11850.229735067192;12073.215241009482;12260.386980650932;12301.69245768845;12035.157538972187;12061.517539298506;12072.275663460221;12093;12150.45322960469;8870.600822962982;8886.555672216364;9048.728538143867;9054.230390416888;9054.411463254868;6127.111568822585;6164.537659675452;6191.84520386994;6221.813345599639;6232.407921247474;10912.61805836792;11147.442627868737;11166.1067114629;11226.158038147008;11307.717307067389;11223.71940701489;11391.715207119889;11458.140639451907;11529.884701153216;11535.423228838692;7805.102413222325;8087.312578430664;8260.793480163044;8323.583820809057;8588.184122508352;9228.261739060725;9415.340926135379;9509.096635819586;9516.524173791144;9538.28462865274;8163.102058773411;8393.118722534291;8396.244338009608;8444.831103378021;8620.827583448421;8059.249820817093;8173.468724532886;8175.877361839696;8208.630611622611;8450.408471406943;7369.042024536776;7490.887636685345;7749.845003100019;7763.650635721293;7914.564698941614;5597.860053498533;5631.267935168402;5657.2928383952;5736.139579063174;5818.0981947798155;5399.649022813504;5420.512153906009;5493.478119578634;5506.669599824023;5642.548596112383 03:54:30 INFO - PROCESS | 22640 | |4;prototype.html;329.20168591166413;331.41836077683666;339.4043453738689;343.5516650770743;347.953026341444;5480.232767412561;5524.171374293858;5553.361363443205;5565.972170139154;5642.125470552071;5486.862828429291;5491.560675145989;5510.421405752399;5512.062949298619;5533.750981205845;4123.855665051724;4303.698741088125;4308.332208507686;4338.154059958301;4342.891427714301;4251.978740106295;4281.507626622932;4295.19601767257;4320.265554855682;4336.132773445308;4290.648445739597;4291.721038132527;4302.247106756321;4314.460692413449;4345.217860785057;4059.451973983504;4085.91723193354;4225.154969006211;4228.985043589516;4231.851885184004;3654.7441679082476;3691.5201023866994;3706.8331925063435;3711.2206436648335;3720.2931443025736;5095.770690318907;5235.476452354772;5250.3962044364625;5270.288511050997;5270.947290527084;4742.9525704742855;4744.16977029022;4769.642276829251;4786.425628924517;4809.831655892027;5574.693391863446;5624.156376543551;5647.689377084259;5652.576056795757;5693.292012396265;3998.10042740384;4094.7338423002707;4107.116969851467;4146.4402305688645;4153.91692166155;5924.792632257893;5935.228420305332;5965.731542080617;6010.308814486346;6022.759089636409;4170.416141740159;4177.248095342807;4201.642860356904;4206.390073439334;4206.41110244566;4172.518755841693;4229.788510574459;4273.230818452708;4280.700350975402;4283.843362292164;4827.879303017382;4830.903381932341;4839.516048395203;4840.2255639097575;4853.781579828846;5737.799177028784;5776.249087618667;5790.971045144747;5798.144593729966;5808.128780682847;1446.978295325571;1486.524312220079;1494.5665756930587;1498.5803974887049;1506.7664512000658;935.3826474526779;947.7346343023964;949.4113649537331;968.6222373274429;975.4781192062212;4923.335349727741;4927.384076990376;4929;4956.4547899731;4975;5243.370795504564;5270.235815806686;5272.446393128743;5274.7890084396195;5281.287026251483;4975.278584605212;5329.600279978939;5369.677819330853;5608.46719561641;5655.745491452894;3134.5298205268937;3141.403133404646;3149.4960806270888;3174.587303650511;3187.8406079695924;5879.235699359056;6122.54080943931;6184.5980011299125;6199.659018753921;6222.377762223832;6060.42425969541;6062.181605483203;6086.786962456381;6091.238595175603;6095.969520152459;6155.353687862799;6192.956324412933;6202.534809889186;6218.968905155445;6221.160143380676;5695.857603559944;5984.341722410619;5993.280806303272;6003.5797494174985;6021.42796434338;5859.007937301338;5874.472637114295;5923;5958.612690175125;5980.581359304807;5857.853553661193;6165.599236049642;6171.537134715004;6229.595076320024;6274.74901003973;4224.8732538023905;4245.448091748053;4263.872083837366;4285.892852678708;4287.249731296948;6060.818175454743;6080.48315893154;6086.513078953762;6138.631682099089;6147.538934579835;5648.209250704823;5748.189320364072;5797.594168408171;5829.688320127937;5843.532517398513;5771.278590176228;5797.507211887037;5813.418658134153;5830.212921255746;5874.853128671817;5445.482679145475;5708.315002199763;5714.542836572981;5718.942810572007;5725.799597014085;5806.229100124503;5808.273965754281;5861.677607731445;5871.354151043467;5891.705414729161;5512.944870551243;5759;5762.30852297727;5771.105478650816;5778.624389414675 03:54:30 INFO - PROCESS | 22640 | |5;yui.html;767.7044337929896;803.4255507312271;855.5294587976612;859.4284800607596;896.3591032411827;14542.127472351653;15354.155521446315;15420.922895385522;15433.691326173484;17033.82966170341;16724.58188545284;17586;17704;17722.46832595021;17742;720.6684924934536;845.5772113943028;880.106691707917;885.5306687455659;888.506878682331;865.4071960706905;880.5289170293894;880.8150288439435;880.9559522023873;881.3610132653839;926.8702381666573;932.4312169576586;933.0529512544772;933.2067742418958;933.2300851797295;756.9583672897988;892.9642814287486;904.4663648447447;926.0091701878993;927.14702473724;675.3651567526509;676.0197713315663;676.1750664189681;676.2223443040493;676.2966514824576;16306.103164325958;16450.341986320534;16473.752893706605;16485.17574121301;16488.83511164885;13747.518836840763;13974;14031.579052628438;14039.78940315896;14057.226852523107;14111.78832317516;14136.363863626162;14516.419343226258;14541.70916581673;14574.927125364411;4653.464851542082;4680.742559159245;4692.2257827458425;4725.22033864412;4746;77749.8337524932;77990;78286;78316;79189.60405197938;11938.820917686242;11943.880561194277;12095.153339266342;12212.816807747891;12236;21053.57892842165;21638.459038523848;21749.456263593536;21751.456213594785;21791.673124902823;9014.729558113268;9386.953065234768;9670.70987870365;9688.612455501701;9806.117449429586;4977.278294647256;5142.202958541432;5209.4009188943;5279.41926388097;5285.207218917193;4005.0387906902715;4230.978845105817;4305.677074219383;4346.760928148982;4350.847720329836;605.1830029460282;746.1493896957472;748.7341993592305;759.369723129801;766.5439063757055;679.6363945289246;682.8804959132132;735.8373769444265;815.1278132398395;818.6234332207132;10476.790464190673;10704.518296676668;10742.140628749681;10790.622328218475;10845.13238940883;631.66837410359;718.392957950531;752.9623518824037;776.6082801756079;795.7970717467125;4934.383202099738;5271.525562699376;5291.735413229323;5356.491133342326;5390.51485366319;74141.62929185427;80413;110897.44551277193;122345.38827305807;125218;101778;108969;109472;110253;110454;74120;96239.51880240694;96311.51844240734;97667;98069.50965245128;9769.951150244204;9861.260405469762;10088.546015429176;10150.289479736348;10417.16662667;55561.887052754246;55969.720151398986;56596.71701641465;58322.12516812166;59058.704706476194;81411.59294203491;81827;82960.58519707363;84019.15980840113;84870.57564712137;12553.560625378068;12629.87370126287;12868.806967895302;12923.418446170133;13254;14730.631734206301;15022.474213402478;15340;15418.46035388756;15563.610909727347;14839.332230049458;15161.848381516043;15165.469208577646;15502;16248.837511625205;14539.200343981183;14932.253387330373;15107.54677359681;15174.165420901514;15187.08144954438;14353.784693229401;14722.705545888808;14943.178125203218;15033.548993530212;15330.463433779763;12226.20529665569;12416.192947458387;12623.558175463815;12701.174423662433;13113.606591802261;11140.164487663296;11881.821772673244;12240.75518489643;12335.50657973671;12440.00479961619 03:54:30 INFO - PROCESS | 22640 | __end_tp_report 03:54:30 INFO - PROCESS | 22640 | __start_cc_report 03:54:30 INFO - PROCESS | 22640 | _x_x_mozilla_cycle_collect,913 03:54:30 INFO - PROCESS | 22640 | __end_cc_report 03:54:30 INFO - PROCESS | 22640 | __startTimestamp1467543270736__endTimestamp 03:54:30 INFO - PROCESS | 22640 | 03:54:30 INFO - PROCESS | 22640 | ------- Summary: start ------- 03:54:30 INFO - PROCESS | 22640 | Number of tests: 6 03:54:30 INFO - PROCESS | 22640 | 03:54:30 INFO - PROCESS | 22640 | [#0] dojo.html Cycles:165 Average:5511.85 Median:5698.86 stddev:618.71 (10.9%) stddev-sans-first:594.66 03:54:30 INFO - PROCESS | 22640 | Values: 3251.7 3275.4 3301.9 3326.5 3345.0 5391.0 5485.7 5526.1 5536.0 5541.3 5493.8 5541.6 5546.3 5548.0 5573.9 4960.5 4998.3 5016.6 5058.7 5088.0 4904.0 5040.2 5070.5 5077.2 5083.3 5006.2 5028.1 5059.7 5092.8 5157.2 5149.9 5164.5 5177.3 5178.4 5188.7 4889.1 4968.7 4995.0 5057.3 5068.9 5353.6 5400.8 5436.8 5464.4 5500.0 5952.1 5998.0 6002.0 6003.0 6006.5 5885.3 5939.9 5943.9 6000.8 6026.0 5597.1 5598.1 5601.5 5609.3 5622.6 5799.6 6066.8 6086.8 6089.1 6092.9 5763.4 5827.4 5837.9 5926.5 5936.6 5991.9 5996.8 6023.5 6026.1 6035.9 5703.8 5837.4 5959.6 5962.2 5972.8 5801.1 5913.9 5929.1 5929.9 5970.6 4515.2 4522.4 4526.1 4530.1 4548.8 3953.3 3977.3 4004.0 4078.9 4105.4 5586.9 5587.7 5610.9 5613.7 5638.8 5952.9 5974.5 5975.0 5978.8 6007.7 5373.4 5522.5 5554.3 5588.1 5606.8 5113.4 5142.1 5147.6 5148.1 5150.0 6174.9 6182.4 6201.9 6206.1 6211.4 5756.2 5885.5 5927.3 5937.3 5966.4 6119.4 6128.8 6129.6 6131.2 6131.5 5649.4 5820.2 5825.7 5852.5 5869.6 5874.7 5907.5 5930.0 5976.3 5989.2 5782.1 5788.0 5832.4 5839.6 5852.2 5640.6 5698.9 5782.0 5842.8 5856.8 5604.7 5659.8 5696.7 5712.8 5744.4 5831.2 5846.5 5865.6 5882.6 5883.4 5585.8 5676.6 5701.3 5715.6 5726.2 03:54:30 INFO - PROCESS | 22640 | 03:54:30 INFO - PROCESS | 22640 | [#1] ext.html Cycles:180 Average:66820.85 Median:39866.70 stddev:137735.97 (345.5%) stddev-sans-first:138032.60 03:54:30 INFO - PROCESS | 22640 | Values: 592.5 633.2 636.1 647.8 651.0 32749.0 45090.5 45607.5 45653.3 45726.5 47649.3 47829.8 47890.0 47931.8 48031.3 8299.8 9010.3 9166.4 9166.8 10890.6 10661.7 10787.4 11125.5 11128.9 11134.1 11184.6 11245.6 11258.2 11259.2 11261.7 8280.1 10729.2 10993.2 11022.2 11042.8 10705.7 10780.7 10781.8 10789.0 10790.5 45535.8 45593.3 45836.5 45941.3 46033.8 3692.8 3818.4 3949.5 3951.9 4465.2 35513.5 35778.6 35791.0 35816.5 35825.6 4579.6 4585.4 4657.1 4668.6 4701.0 376065.0 378679.0 380075.0 382252.0 382930.0 68579.7 68757.3 69070.7 69086.0 69134.7 40586.0 41719.2 41748.8 43585.3 43655.0 16712.4 16989.2 17058.7 17068.0 17072.1 11290.5 12700.0 12853.2 12899.4 13092.3 21984.5 22323.3 22330.3 22342.4 22350.9 7690.0 7697.6 7867.7 7890.9 7972.1 817.7 844.2 953.2 991.4 1018.7 33567.5 33881.3 34014.7 34247.7 34573.7 1081.4 1096.6 1098.9 1120.9 1127.1 16522.2 16679.2 16714.7 16809.6 17192.9 643807.0 645744.0 647728.0 650364.0 650452.0 59937.4 59955.7 60322.7 60423.0 60532.0 1266.7 1362.9 1380.3 1394.8 1409.5 30817.5 33336.5 33944.0 34299.1 34384.3 52274.0 52658.2 52728.5 52805.2 52806.2 485355.0 490023.0 490364.0 490860.0 491037.0 30320.4 30468.7 31480.7 31639.4 32795.8 50670.7 52097.2 52332.7 52709.7 52736.7 43295.1 43785.3 44045.3 44181.6 44244.8 43432.6 43749.3 44096.1 44171.8 44887.6 40035.4 43257.4 43964.1 44037.0 44272.0 38171.2 38775.0 38963.6 39161.3 39698.0 29086.0 29122.1 29128.6 29545.7 29606.7 03:54:30 INFO - PROCESS | 22640 | 03:54:30 INFO - PROCESS | 22640 | [#2] jquery.html Cycles:180 Average:28084.90 Median:12896.21 stddev:75321.05 (584.1%) stddev-sans-first:75503.66 03:54:30 INFO - PROCESS | 22640 | Values: 401.4 410.9 415.5 421.5 427.6 18746.0 19644.6 19839.4 20191.9 20340.9 19458.2 19759.9 20210.0 20370.4 20396.6 5707.3 6040.8 6048.4 6049.2 6049.7 5731.2 5913.1 5982.1 5982.9 6030.8 5955.5 5988.0 5989.7 6010.3 6010.6 5730.9 5980.7 5981.3 5982.5 5990.1 5340.2 5345.4 5352.2 5359.3 5379.1 23446.8 23520.2 23630.5 24210.9 24291.3 2268.7 2303.7 2333.5 2345.7 2345.7 14855.8 15187.7 15346.4 15478.8 15536.1 2028.4 2046.9 2091.1 2105.3 2112.5 77903.0 79469.2 80358.6 80409.0 82021.6 10867.1 11018.6 11169.5 11228.4 11326.1 15713.7 15822.6 15837.1 15857.1 16025.5 8217.7 8480.7 8529.8 8543.8 8601.1 8051.6 8097.9 8111.6 8199.8 8332.9 6924.9 7006.0 7063.8 7077.7 7109.4 1838.8 1943.4 1961.0 2005.1 2030.3 927.3 1002.5 1010.7 1061.8 1087.5 17916.5 20139.8 20373.3 20403.0 20725.2 996.4 1049.3 1071.3 1075.1 1125.5 10503.0 11613.8 11639.3 11778.3 11816.8 448613.0 457288.0 459535.0 460082.0 465581.0 54248.7 81742.6 86617.6 87093.0 88217.0 1061.4 1079.4 1085.0 1097.2 1110.1 18086.7 18245.5 18265.0 18295.3 18391.0 37475.8 38496.4 39439.4 39932.2 39958.8 53366.5 53428.5 53476.3 53644.5 53754.2 9143.3 9226.2 9283.7 9342.7 9464.9 14384.9 14405.2 14455.9 14466.9 14611.3 12384.9 12540.2 12582.4 12759.8 12841.6 12133.7 12219.1 12314.0 12863.4 13063.1 6092.9 12504.6 12771.9 13003.5 13023.3 9205.9 9299.3 9344.8 9347.1 9490.0 12535.4 12554.9 12580.1 12697.0 12714.6 03:54:30 INFO - PROCESS | 22640 | 03:54:30 INFO - PROCESS | 22640 | [#3] mootools.html Cycles:180 Average:6276.73 Median:2532.80 stddev:3718.34 (146.8%) stddev-sans-first:3709.69 03:54:30 INFO - PROCESS | 22640 | Values: 1265.2 1494.9 1535.0 1656.8 1859.6 9053.8 9305.3 9374.5 9610.7 9642.5 9424.6 9632.7 9637.7 9649.1 9652.5 2112.7 2412.7 2419.9 2449.7 2489.8 2504.3 2514.9 2520.1 2522.6 2523.0 2381.4 2442.3 2444.2 2445.4 2447.6 2107.1 2378.5 2405.9 2434.9 2444.9 2392.7 2403.7 2406.2 2412.0 2427.1 9546.5 9550.1 9575.6 9625.4 9629.3 5404.1 5540.3 5543.4 5553.2 5554.1 3426.3 3500.6 3559.2 3560.6 3563.9 1070.9 1092.6 1108.6 1120.4 1146.0 13766.8 13861.7 13871.6 13873.2 13880.5 4746.9 4767.9 4788.6 4819.6 4831.1 11308.7 11398.4 11413.6 11413.7 11421.2 5520.7 5525.4 5528.8 5531.7 5538.7 4476.9 5012.6 5134.9 5145.8 5194.1 4267.0 4294.0 4344.0 4348.4 4427.8 1257.1 1270.5 1286.6 1288.7 1300.3 897.8 966.4 985.5 1007.5 1031.9 6355.9 6494.3 6536.4 6553.3 6615.7 437.3 450.4 458.3 460.6 462.8 4340.8 4438.8 4531.8 4574.5 4605.0 11640.0 11850.2 12073.2 12260.4 12301.7 12035.2 12061.5 12072.3 12093.0 12150.5 8870.6 8886.6 9048.7 9054.2 9054.4 6127.1 6164.5 6191.8 6221.8 6232.4 10912.6 11147.4 11166.1 11226.2 11307.7 11223.7 11391.7 11458.1 11529.9 11535.4 7805.1 8087.3 8260.8 8323.6 8588.2 9228.3 9415.3 9509.1 9516.5 9538.3 8163.1 8393.1 8396.2 8444.8 8620.8 8059.2 8173.5 8175.9 8208.6 8450.4 7369.0 7490.9 7749.8 7763.7 7914.6 5597.9 5631.3 5657.3 5736.1 5818.1 5399.6 5420.5 5493.5 5506.7 5642.5 03:54:30 INFO - PROCESS | 22640 | 03:54:30 INFO - PROCESS | 22640 | [#4] prototype.html Cycles:180 Average:4824.88 Median:5489.21 stddev:1430.68 (26.1%) stddev-sans-first:1394.33 03:54:30 INFO - PROCESS | 22640 | Values: 329.2 331.4 339.4 343.6 348.0 5480.2 5524.2 5553.4 5566.0 5642.1 5486.9 5491.6 5510.4 5512.1 5533.8 4123.9 4303.7 4308.3 4338.2 4342.9 4252.0 4281.5 4295.2 4320.3 4336.1 4290.6 4291.7 4302.2 4314.5 4345.2 4059.5 4085.9 4225.2 4229.0 4231.9 3654.7 3691.5 3706.8 3711.2 3720.3 5095.8 5235.5 5250.4 5270.3 5270.9 4743.0 4744.2 4769.6 4786.4 4809.8 5574.7 5624.2 5647.7 5652.6 5693.3 3998.1 4094.7 4107.1 4146.4 4153.9 5924.8 5935.2 5965.7 6010.3 6022.8 4170.4 4177.2 4201.6 4206.4 4206.4 4172.5 4229.8 4273.2 4280.7 4283.8 4827.9 4830.9 4839.5 4840.2 4853.8 5737.8 5776.2 5791.0 5798.1 5808.1 1447.0 1486.5 1494.6 1498.6 1506.8 935.4 947.7 949.4 968.6 975.5 4923.3 4927.4 4929.0 4956.5 4975.0 5243.4 5270.2 5272.4 5274.8 5281.3 4975.3 5329.6 5369.7 5608.5 5655.7 3134.5 3141.4 3149.5 3174.6 3187.8 5879.2 6122.5 6184.6 6199.7 6222.4 6060.4 6062.2 6086.8 6091.2 6096.0 6155.4 6193.0 6202.5 6219.0 6221.2 5695.9 5984.3 5993.3 6003.6 6021.4 5859.0 5874.5 5923.0 5958.6 5980.6 5857.9 6165.6 6171.5 6229.6 6274.7 4224.9 4245.4 4263.9 4285.9 4287.2 6060.8 6080.5 6086.5 6138.6 6147.5 5648.2 5748.2 5797.6 5829.7 5843.5 5771.3 5797.5 5813.4 5830.2 5874.9 5445.5 5708.3 5714.5 5718.9 5725.8 5806.2 5808.3 5861.7 5871.4 5891.7 5512.9 5759.0 5762.3 5771.1 5778.6 03:54:30 INFO - PROCESS | 22640 | 03:54:30 INFO - PROCESS | 22640 | [#5] yui.html Cycles:180 Average:21890.64 Median:4502.16 stddev:30815.37 (684.5%) stddev-sans-first:30860.99 03:54:30 INFO - PROCESS | 22640 | Values: 767.7 803.4 855.5 859.4 896.4 14542.1 15354.2 15420.9 15433.7 17033.8 16724.6 17586.0 17704.0 17722.5 17742.0 720.7 845.6 880.1 885.5 888.5 865.4 880.5 880.8 881.0 881.4 926.9 932.4 933.1 933.2 933.2 757.0 893.0 904.5 926.0 927.1 675.4 676.0 676.2 676.2 676.3 16306.1 16450.3 16473.8 16485.2 16488.8 13747.5 13974.0 14031.6 14039.8 14057.2 14111.8 14136.4 14516.4 14541.7 14574.9 4653.5 4680.7 4692.2 4725.2 4746.0 77749.8 77990.0 78286.0 78316.0 79189.6 11938.8 11943.9 12095.2 12212.8 12236.0 21053.6 21638.5 21749.5 21751.5 21791.7 9014.7 9387.0 9670.7 9688.6 9806.1 4977.3 5142.2 5209.4 5279.4 5285.2 4005.0 4231.0 4305.7 4346.8 4350.8 605.2 746.1 748.7 759.4 766.5 679.6 682.9 735.8 815.1 818.6 10476.8 10704.5 10742.1 10790.6 10845.1 631.7 718.4 753.0 776.6 795.8 4934.4 5271.5 5291.7 5356.5 5390.5 74141.6 80413.0 110897.4 122345.4 125218.0 101778.0 108969.0 109472.0 110253.0 110454.0 74120.0 96239.5 96311.5 97667.0 98069.5 9770.0 9861.3 10088.5 10150.3 10417.2 55561.9 55969.7 56596.7 58322.1 59058.7 81411.6 81827.0 82960.6 84019.2 84870.6 12553.6 12629.9 12868.8 12923.4 13254.0 14730.6 15022.5 15340.0 15418.5 15563.6 14839.3 15161.8 15165.5 15502.0 16248.8 14539.2 14932.3 15107.5 15174.2 15187.1 14353.8 14722.7 14943.2 15033.5 15330.5 12226.2 12416.2 12623.6 12701.2 13113.6 11140.2 11881.8 12240.8 12335.5 12440.0 03:54:30 INFO - PROCESS | 22640 | -------- Summary: end -------- 03:54:30 INFO - PROCESS | 22640 | 03:54:31 INFO - TEST-INFO | 22640: exit 0 03:54:31 INFO - TEST-OK | dromaeo_css | took 1112785ms 03:54:31 INFO - TEST-START | kraken 03:54:31 INFO - operating with platform_type : linux_ 03:54:31 INFO - Initialising browser for kraken test... 03:54:31 INFO - TEST-INFO | started process 22834 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM1emTn/profile http://localhost:42147/getInfo.html) 03:54:35 INFO - PROCESS | 22834 | __metrics Screen width/height:1600/1200 03:54:35 INFO - PROCESS | 22834 | colorDepth:24 03:54:35 INFO - PROCESS | 22834 | Browser inner width/height: 1024/697 03:54:35 INFO - PROCESS | 22834 | __metrics 03:54:36 ERROR - PROCESS | 22834 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:54:37 INFO - TEST-INFO | 22834: exit 0 03:54:37 INFO - Browser initialized. 03:54:37 INFO - Running cycle 1/1 for kraken test... 03:54:37 INFO - TEST-INFO | started process 22924 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM1emTn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:54:48 INFO - PROCESS | 22924 | RSS: Main: 145149952 03:54:48 INFO - PROCESS | 22924 | 03:54:51 INFO - PROCESS | 22924 | Cycle 1(1): loaded http://localhost:42147/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42147/tests/kraken/driver.html?testName=audio-beat-detection) 03:54:52 INFO - PROCESS | 22924 | RSS: Main: 194842624 03:54:52 INFO - PROCESS | 22924 | 03:54:54 INFO - PROCESS | 22924 | Cycle 1(1): loaded http://localhost:42147/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42147/tests/kraken/driver.html?testName=audio-dft) 03:54:55 INFO - PROCESS | 22924 | RSS: Main: 193265664 03:54:55 INFO - PROCESS | 22924 | 03:54:58 INFO - PROCESS | 22924 | Cycle 1(1): loaded http://localhost:42147/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42147/tests/kraken/driver.html?testName=audio-fft) 03:54:58 INFO - PROCESS | 22924 | RSS: Main: 278908928 03:54:58 INFO - PROCESS | 22924 | 03:55:00 INFO - PROCESS | 22924 | Cycle 1(1): loaded http://localhost:42147/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42147/tests/kraken/driver.html?testName=audio-oscillator) 03:55:01 INFO - PROCESS | 22924 | RSS: Main: 187363328 03:55:01 INFO - PROCESS | 22924 | 03:55:03 INFO - PROCESS | 22924 | Cycle 1(1): loaded http://localhost:42147/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42147/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:55:04 INFO - PROCESS | 22924 | RSS: Main: 188051456 03:55:04 INFO - PROCESS | 22924 | 03:55:07 INFO - PROCESS | 22924 | Cycle 1(1): loaded http://localhost:42147/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42147/tests/kraken/driver.html?testName=imaging-darkroom) 03:55:07 INFO - PROCESS | 22924 | RSS: Main: 223100928 03:55:07 INFO - PROCESS | 22924 | 03:55:11 INFO - PROCESS | 22924 | Cycle 1(1): loaded http://localhost:42147/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42147/tests/kraken/driver.html?testName=imaging-desaturate) 03:55:11 INFO - PROCESS | 22924 | RSS: Main: 222150656 03:55:11 INFO - PROCESS | 22924 | 03:55:14 INFO - PROCESS | 22924 | Cycle 1(1): loaded http://localhost:42147/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42147/tests/kraken/driver.html?testName=json-parse-financial) 03:55:15 INFO - PROCESS | 22924 | RSS: Main: 221614080 03:55:15 INFO - PROCESS | 22924 | 03:55:16 INFO - PROCESS | 22924 | Cycle 1(1): loaded http://localhost:42147/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42147/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:55:17 INFO - PROCESS | 22924 | RSS: Main: 200212480 03:55:17 INFO - PROCESS | 22924 | 03:55:18 INFO - PROCESS | 22924 | Cycle 1(1): loaded http://localhost:42147/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42147/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:55:19 INFO - PROCESS | 22924 | RSS: Main: 199954432 03:55:19 INFO - PROCESS | 22924 | 03:55:21 INFO - PROCESS | 22924 | Cycle 1(1): loaded http://localhost:42147/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42147/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:55:22 INFO - PROCESS | 22924 | RSS: Main: 210079744 03:55:22 INFO - PROCESS | 22924 | 03:55:24 INFO - PROCESS | 22924 | Cycle 1(1): loaded http://localhost:42147/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42147/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:55:25 INFO - PROCESS | 22924 | RSS: Main: 213131264 03:55:25 INFO - PROCESS | 22924 | 03:55:27 INFO - PROCESS | 22924 | Cycle 1(1): loaded http://localhost:42147/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42147/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:55:28 INFO - PROCESS | 22924 | RSS: Main: 214642688 03:55:28 INFO - PROCESS | 22924 | 03:55:30 INFO - PROCESS | 22924 | Cycle 1(1): loaded http://localhost:42147/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42147/tests/kraken/driver.html?testName=ai-astar) 03:55:30 INFO - PROCESS | 22924 | RSS: Main: 257818624 03:55:30 INFO - PROCESS | 22924 | 03:55:30 INFO - PROCESS | 22924 | __start_tp_report 03:55:30 INFO - PROCESS | 22924 | _x_x_mozilla_page_load 03:55:30 INFO - PROCESS | 22924 | _x_x_mozilla_page_load_details 03:55:30 INFO - PROCESS | 22924 | |i|pagename|runs| 03:55:30 INFO - PROCESS | 22924 | |0;ai-astar;110;106;108;108;110;110;108;110;109;110 03:55:30 INFO - PROCESS | 22924 | |1;audio-beat-detection;155;124;130;178;123;126;153;125;166;124 03:55:30 INFO - PROCESS | 22924 | |2;audio-dft;159;159;159;161;161;162;161;160;160;160 03:55:30 INFO - PROCESS | 22924 | |3;audio-fft;76;74;76;120;75;77;73;75;98;75 03:55:30 INFO - PROCESS | 22924 | |4;audio-oscillator;84;84;110;85;86;84;110;86;84;129 03:55:30 INFO - PROCESS | 22924 | |5;imaging-gaussian-blur;116;117;116;116;117;117;117;117;117;117 03:55:30 INFO - PROCESS | 22924 | |6;imaging-darkroom;146;145;145;147;147;145;145;145;145;145 03:55:30 INFO - PROCESS | 22924 | |7;imaging-desaturate;95;95;95;95;95;95;97;94;95;94 03:55:30 INFO - PROCESS | 22924 | |8;json-parse-financial;50;50;51;52;53;52;54;53;51;52 03:55:30 INFO - PROCESS | 22924 | |9;json-stringify-tinderbox;58;61;58;58;59;59;59;59;58;59 03:55:30 INFO - PROCESS | 22924 | |10;stanford-crypto-aes;83;82;76;82;81;80;77;77;110;77 03:55:30 INFO - PROCESS | 22924 | |11;stanford-crypto-ccm;119;119;118;121;127;117;131;141;123;128 03:55:30 INFO - PROCESS | 22924 | |12;stanford-crypto-pbkdf2;157;159;152;152;151;155;154;153;157;153 03:55:30 INFO - PROCESS | 22924 | |13;stanford-crypto-sha256-iterative;61;65;61;60;61;61;62;61;61;59 03:55:30 INFO - PROCESS | 22924 | __end_tp_report 03:55:30 INFO - PROCESS | 22924 | __start_cc_report 03:55:30 INFO - PROCESS | 22924 | _x_x_mozilla_cycle_collect,1566 03:55:30 INFO - PROCESS | 22924 | __end_cc_report 03:55:30 INFO - PROCESS | 22924 | __startTimestamp1467543330431__endTimestamp 03:55:30 INFO - PROCESS | 22924 | 03:55:30 INFO - PROCESS | 22924 | ------- Summary: start ------- 03:55:30 INFO - PROCESS | 22924 | Number of tests: 14 03:55:30 INFO - PROCESS | 22924 | 03:55:30 INFO - PROCESS | 22924 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.00 stddev:1.37 (1.2%) stddev-sans-first:1.39 03:55:30 INFO - PROCESS | 22924 | Values: 110.0 106.0 108.0 108.0 110.0 110.0 108.0 110.0 109.0 110.0 03:55:30 INFO - PROCESS | 22924 | 03:55:30 INFO - PROCESS | 22924 | [#1] audio-beat-detection Cycles:10 Average:140.40 Median:141.50 stddev:20.64 (14.6%) stddev-sans-first:21.21 03:55:30 INFO - PROCESS | 22924 | Values: 155.0 124.0 130.0 178.0 123.0 126.0 153.0 125.0 166.0 124.0 03:55:30 INFO - PROCESS | 22924 | 03:55:30 INFO - PROCESS | 22924 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.50 stddev:1.03 (0.6%) stddev-sans-first:1.00 03:55:30 INFO - PROCESS | 22924 | Values: 159.0 159.0 159.0 161.0 161.0 162.0 161.0 160.0 160.0 160.0 03:55:30 INFO - PROCESS | 22924 | 03:55:30 INFO - PROCESS | 22924 | [#3] audio-fft Cycles:10 Average:81.90 Median:75.50 stddev:15.23 (20.2%) stddev-sans-first:16.01 03:55:30 INFO - PROCESS | 22924 | Values: 76.0 74.0 76.0 120.0 75.0 77.0 73.0 75.0 98.0 75.0 03:55:30 INFO - PROCESS | 22924 | 03:55:30 INFO - PROCESS | 22924 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:84.00 stddev:16.14 (19.2%) stddev-sans-first:16.70 03:55:30 INFO - PROCESS | 22924 | Values: 84.0 84.0 110.0 85.0 86.0 84.0 110.0 86.0 84.0 129.0 03:55:30 INFO - PROCESS | 22924 | 03:55:30 INFO - PROCESS | 22924 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 03:55:30 INFO - PROCESS | 22924 | Values: 116.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 03:55:30 INFO - PROCESS | 22924 | 03:55:30 INFO - PROCESS | 22924 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 03:55:30 INFO - PROCESS | 22924 | Values: 146.0 145.0 145.0 147.0 147.0 145.0 145.0 145.0 145.0 145.0 03:55:30 INFO - PROCESS | 22924 | 03:55:30 INFO - PROCESS | 22924 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 03:55:30 INFO - PROCESS | 22924 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 97.0 94.0 95.0 94.0 03:55:30 INFO - PROCESS | 22924 | 03:55:30 INFO - PROCESS | 22924 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:52.00 stddev:1.32 (2.5%) stddev-sans-first:1.22 03:55:30 INFO - PROCESS | 22924 | Values: 50.0 50.0 51.0 52.0 53.0 52.0 54.0 53.0 51.0 52.0 03:55:30 INFO - PROCESS | 22924 | 03:55:30 INFO - PROCESS | 22924 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:59.00 stddev:0.92 (1.6%) stddev-sans-first:0.93 03:55:30 INFO - PROCESS | 22924 | Values: 58.0 61.0 58.0 58.0 59.0 59.0 59.0 59.0 58.0 59.0 03:55:30 INFO - PROCESS | 22924 | 03:55:30 INFO - PROCESS | 22924 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:80.50 stddev:9.99 (12.4%) stddev-sans-first:10.60 03:55:30 INFO - PROCESS | 22924 | Values: 83.0 82.0 76.0 82.0 81.0 80.0 77.0 77.0 110.0 77.0 03:55:30 INFO - PROCESS | 22924 | 03:55:30 INFO - PROCESS | 22924 | [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:125.00 stddev:7.50 (6.0%) stddev-sans-first:7.70 03:55:30 INFO - PROCESS | 22924 | Values: 119.0 119.0 118.0 121.0 127.0 117.0 131.0 141.0 123.0 128.0 03:55:30 INFO - PROCESS | 22924 | 03:55:30 INFO - PROCESS | 22924 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.30 Median:154.50 stddev:2.63 (1.7%) stddev-sans-first:2.60 03:55:30 INFO - PROCESS | 22924 | Values: 157.0 159.0 152.0 152.0 151.0 155.0 154.0 153.0 157.0 153.0 03:55:30 INFO - PROCESS | 22924 | 03:55:30 INFO - PROCESS | 22924 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.20 Median:61.00 stddev:1.55 (2.5%) stddev-sans-first:1.64 03:55:30 INFO - PROCESS | 22924 | Values: 61.0 65.0 61.0 60.0 61.0 61.0 62.0 61.0 61.0 59.0 03:55:30 INFO - PROCESS | 22924 | -------- Summary: end -------- 03:55:30 INFO - PROCESS | 22924 | 03:55:31 INFO - TEST-INFO | 22924: exit 0 03:55:31 INFO - TEST-OK | kraken | took 59961ms 03:55:31 INFO - SUITE-END | took 1172s 03:55:31 INFO - Completed test suite (00:19:32) 03:55:31 INFO - javascript benchmark 03:55:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3251.691089346513, 3275.377678241134, 3301.867925282989, 3326.517654940032, 3345.0466617014154, 5390.973045134779, 5485.725713714313, 5526.06056970315, 5535.972320138399, 5541.27963364763, 5493.752781124849, 5541.612087153891, 5546.334439867212, 5548.0, 5573.860653483665, 4960.503949605047, 4998.300237966688, 5016.598672106223, 5058.747062646871, 5087.974560127194, 4903.950960490385, 5040.218766091243, 5070.5183007614405, 5077.238414237857, 5083.288339632454, 5006.249062640597, 5028.069807085682, 5059.696418214919, 5092.821751238707, 5157.174852023677, 5149.922751158736, 5164.535191832715, 5177.275181474596, 5178.378594568639, 5188.662736922088, 4889.144399730033, 4968.726720030397, 4995.0, 5057.342545469102, 5068.923966140511, 5353.625246232727, 5400.756965936543, 5436.755346009439, 5464.398916119224, 5499.972500137514, 5952.136940143655, 5998.040313549855, 6002.009668404708, 6003.039513677791, 6006.519478441758, 5885.293764748215, 5939.910901336483, 5943.940560594425, 6000.8499787505225, 6025.969870150665, 5597.132444471114, 5598.076317407623, 5601.495865372095, 5609.3268807742925, 5622.606417550732, 5799.594028418054, 6066.827797573087, 6086.817395478054, 6089.086637004485, 6092.878142437126, 5763.394843541368, 5827.388124246978, 5837.854053648693, 5926.466618004314, 5936.554758393051, 5991.850203744942, 5996.790112346047, 6023.548233882389, 6026.126211699367, 6035.8792824143275, 5703.800366987219, 5837.445442682938, 5959.612625179436, 5962.2249107615735, 5972.820815375546, 5801.129830525455, 5913.881722365529, 5929.0513517836935, 5929.940700593025, 5970.582059255898, 4515.209838278354, 4522.389477420572, 4526.072155208174, 4530.116627257719, 4548.7725613719185, 3953.327934251184, 3977.3039718049226, 4004.01901534126, 4078.938815917764, 4105.4252404663375, 5586.888262234733, 5587.664740115606, 5610.915836262459, 5613.719314034363, 5638.802641907513, 5952.8809423812145, 5974.462298393166, 5975.0, 5978.760849566055, 6007.669578173155, 5373.435789242151, 5522.502974732293, 5554.333479982347, 5588.0779671354585, 5606.775728970877, 5113.437521872591, 5142.100132476801, 5147.588192944556, 5148.099082660594, 5150.021495915764, 6174.938250617436, 6182.443580077815, 6201.937980620136, 6206.0690896365, 6211.378862113753, 5756.165356023437, 5885.529157667291, 5927.347991720993, 5937.317208521075, 5966.403359664172, 6119.35746746603, 6128.816135515942, 6129.570930035033, 6131.233595800525, 6131.478824299985, 5649.37856835756, 5820.185174075717, 5825.737841797214, 5852.473277405054, 5869.647821130746, 5874.735636896436, 5907.4683278505145, 5929.970350148222, 5976.282846058501, 5989.1914591529585, 5782.10377391505, 5788.044972579645, 5832.387599302012, 5839.620424672383, 5852.209951656472, 5640.605157638925, 5698.857528561819, 5781.971090144522, 5842.766289348378, 5856.765729370948, 5604.663720176803, 5659.773609055592, 5696.743646535999, 5712.828615141552, 5744.368119506935, 5831.1836342912875, 5846.473817356458, 5865.648061116347, 5882.588218824641, 5883.382244864228, 5585.776568937359, 5676.602637815313, 5701.344345400332, 5715.628484148517, 5726.198332233407], "value": 5471.087544792839, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.4726992976252, 633.2116514938899, 636.0522820996715, 647.8348021254579, 651.042966838747, 32749.0, 45090.54909450904, 45607.54392456074, 45653.31520027198, 45726.54273457264, 47649.28526072103, 47829.76085119569, 47890.0, 47931.76034119833, 48031.27953080706, 8299.83400331993, 9010.279177665803, 9166.40418372807, 9166.770830729218, 10890.61882834101, 10661.680149595524, 10787.352758834495, 11125.499352529116, 11128.944355278212, 11134.10927125832, 11184.552617895275, 11245.60640377587, 11258.211925165242, 11259.21185517014, 11261.662150135468, 8280.130586288444, 10729.195310351755, 10993.230473866832, 11022.173336999676, 11042.834357484644, 10705.678829635046, 10780.676579702622, 10781.838272425919, 10789.0, 10790.51442685081, 45535.77232113852, 45593.316100258526, 45836.54163458356, 45941.31088033682, 46033.76983115063, 3692.7968961707097, 3818.389057750774, 3949.5063117110362, 3951.8616848410165, 4465.213904537494, 35513.46729799055, 35778.64221357779, 35791.0, 35816.462753058724, 35825.64174358275, 4579.592605628552, 4585.449746030465, 4657.138429390574, 4668.649851261169, 4700.976495117537, 376065.0, 378679.0, 380074.9999999972, 382252.0, 382930.0, 68579.65710171417, 68757.31242687609, 69070.65464672644, 69086.0, 69134.65432672805, 40586.0, 41719.1656166875, 41748.79125604413, 43585.34621980673, 43655.0, 16712.415065472895, 16989.23548440323, 17058.658826823394, 17068.0, 17072.146392680315, 11290.491927863266, 12700.0, 12853.16454430459, 12899.35503224835, 13092.279924604049, 21984.45038874041, 22323.330300091024, 22330.320361556718, 22342.43602947778, 22350.888245558668, 7690.0, 7697.576633285111, 7867.685292588347, 7890.8816367754525, 7972.083210430758, 817.7464985854405, 844.1980118887082, 953.2278854128178, 991.3902949685892, 1018.6943916825071, 33567.49648755271, 33881.32237355288, 34014.659853401645, 34247.65752342495, 34573.654263457545, 1081.3836113415277, 1096.6107032003683, 1098.9395583242838, 1120.8542889424323, 1127.115214556569, 16522.173891305385, 16679.24943377551, 16714.6657066858, 16809.579760506083, 17192.914035429993, 643807.0, 645744.0, 647728.0, 650364.0, 650452.0, 59937.400625993185, 59955.70022149861, 60322.698386508666, 60423.0, 60532.0, 1266.7086570088748, 1362.863713628649, 1380.3167432120963, 1394.8326200855963, 1409.5489443378226, 30817.537736934413, 33336.49995250122, 33944.0, 34299.14252143716, 34384.312313753086, 52274.0, 52658.21012684736, 52728.47271527236, 52805.207921880436, 52806.2079068822, 485355.0, 490023.0, 490364.0, 490860.0, 491037.0, 30320.39359212759, 30468.695313046584, 31480.685193148693, 31639.367212656078, 32795.836020820694, 50670.74664626653, 52097.218541722665, 52332.73833630807, 52709.7364513175, 52736.73631631817, 43295.108359133126, 43785.343219852366, 44045.33931991087, 44181.55818441774, 44244.778776105915, 43432.565674344114, 43749.34375984299, 44096.11807763891, 44171.77914110409, 44887.55112448834, 40035.3994690074, 43257.35113973356, 43964.120717586105, 44037.0, 44272.0, 38171.23657526779, 38775.0, 38963.610363896, 39161.314507059855, 39698.0, 29086.0, 29122.12633620995, 29128.56307155352, 29545.704542954296, 29606.703932960394], "value": 21458.738637920673, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.37385678341786, 410.9301418758812, 415.4693072049303, 421.5426262505182, 427.56174920706275, 18746.0, 19644.607107857835, 19839.40481785547, 20191.899040504813, 20340.89829550852, 19458.221671133175, 19759.901200493976, 20209.956785304024, 20370.38888833334, 20396.59206815863, 5707.286589176363, 6040.848978775522, 6048.425399587032, 6049.153118563405, 6049.727762250687, 5731.197632331477, 5913.113033045035, 5982.132590774335, 5982.8504287392725, 6030.788922387717, 5955.464008239258, 5988.0, 5989.730462129193, 6010.27876654802, 6010.609310394832, 5730.885382292352, 5980.73086711099, 5981.312149102865, 5982.491488223506, 5990.101484777275, 5340.225667278261, 5345.4387289334445, 5352.2239275305255, 5359.303290572239, 5379.1393377059485, 23446.765532344627, 23520.176793812305, 23630.527389452287, 24210.878945605335, 24291.271261862174, 2268.7408488288993, 2303.7120359955006, 2333.5099629077913, 2345.6598793175067, 2345.7067866516686, 14855.77716334245, 15187.696246075016, 15346.386144554204, 15478.767818482731, 15536.145511996836, 2028.4117605894273, 2046.8567200295986, 2091.0903756865814, 2105.315772373969, 2112.4718820294925, 77903.0, 79469.20530794676, 80358.59820700917, 80409.0, 82021.58989205016, 10867.130629549618, 11018.614348497764, 11169.497372618252, 11228.382438965935, 11326.093912486982, 15713.68572628541, 15822.60443488922, 15837.128957907426, 15857.127857967691, 16025.519234422753, 8217.671293148327, 8480.703175388831, 8529.829403411897, 8543.786405339917, 8601.096884827128, 8051.63767630458, 8097.878531822027, 8111.553864537507, 8199.754007379788, 8332.916670833214, 6924.93075069253, 7005.984132300788, 7063.752768653175, 7077.7168913242895, 7109.360157585842, 1838.7517685112607, 1943.416974907522, 1960.9901950490157, 2005.1478121798177, 2030.2691031228746, 927.332320729074, 1002.5137808163036, 1010.7018429563296, 1061.830107182847, 1087.5377964365114, 17916.462506124837, 20139.79860201379, 20373.286934957207, 20403.0, 20725.170993160405, 996.4419924842111, 1049.2602715085845, 1071.2501249125644, 1075.0969185883896, 1125.5441546173813, 10503.0, 11613.825792613117, 11639.301641901513, 11778.293302401884, 11816.76366472683, 448613.0, 457288.0, 459535.0, 460082.0, 465581.0, 54248.728756355966, 81742.59128704437, 86617.5669121663, 87093.0, 88217.0, 1061.363182090755, 1079.3577821196532, 1084.9945750271356, 1097.1716354152563, 1110.0509064749524, 18086.728699069263, 18245.54386140357, 18265.0, 18295.26818927228, 18391.0, 37475.81262093672, 38496.422553662276, 39439.408408874464, 39932.2013559733, 39958.800205998785, 53366.46633533615, 53428.465715343904, 53476.331360946184, 53644.46355536551, 53754.193687093946, 9143.26853851677, 9226.169644732006, 9283.67507137274, 9342.673006445013, 9464.905350946403, 14384.856151438351, 14405.207713575854, 14455.85544144545, 14466.927665362027, 14611.269436528344, 12384.938075309567, 12540.24758514492, 12582.370881455707, 12759.808602870778, 12841.550545731228, 12133.696657583278, 12219.144659874079, 12314.0, 12863.356832158168, 13063.085584009408, 6092.939070609415, 12504.624861254177, 12771.87228127744, 13003.479860805463, 13023.348832558524, 9205.861912071457, 9299.256059515357, 9344.784692314946, 9347.112024357675, 9490.003549627467, 12535.373231338579, 12554.937225313815, 12580.056495762672, 12697.047721421115, 12714.554990575285], "value": 9654.498180169474, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1265.2155663488638, 1494.9327280272382, 1535.0099186025013, 1656.8177500474947, 1859.5908900041986, 9053.773655658604, 9305.255579553637, 9374.484403357812, 9610.663626773065, 9642.469664168468, 9424.623015079389, 9632.662856800014, 9637.71086867395, 9649.083337082984, 9652.517374131283, 2112.71478350423, 2412.6984126984125, 2419.903203871843, 2449.7427770084064, 2489.7634724701124, 2504.2987963370288, 2514.8742562871876, 2520.080170737686, 2522.646829443879, 2522.962155567668, 2381.38084098134, 2442.2917353967327, 2444.1934161726585, 2445.3764290105996, 2447.632855071736, 2107.051826677993, 2378.5361854438393, 2405.855648661086, 2434.8782560871887, 2444.8655323957173, 2392.676988606533, 2403.723571789249, 2406.217979156781, 2411.9517609647883, 2427.1262345555588, 9546.474943878153, 9550.140487356102, 9575.61697532098, 9625.422474651543, 9629.277804164716, 5404.054290499147, 5540.307461567304, 5543.362513310981, 5553.194786755897, 5554.1391084381985, 3426.3318652862704, 3500.562429696288, 3559.181388280684, 3560.608333083359, 3563.875264365761, 1070.8554345163382, 1092.6121226964392, 1108.5898217659437, 1120.4229821641861, 1145.9885401145966, 13766.793498097437, 13861.722765544733, 13871.583852484442, 13873.236971966538, 13880.51418200358, 4746.905061898743, 4767.928481072787, 4788.569028787426, 4819.59033482151, 4831.050992240229, 11308.660740177807, 11398.373089480157, 11413.60052398162, 11413.657590272305, 11421.200515963968, 5520.723963801794, 5525.4474552544425, 5528.778848846001, 5531.695756733418, 5538.723063846872, 4476.910461790746, 5012.573931215815, 5134.948650513447, 5145.845624631267, 5194.065068287745, 4266.957330426718, 4294.0, 4343.978280108579, 4348.412964249786, 4427.822887084545, 1257.0948916779903, 1270.5362542671858, 1286.6204469681466, 1288.6842723532795, 1300.3498250874563, 897.8069715011304, 966.4153187321709, 985.5072463768116, 1007.536533194724, 1031.8761748590218, 6355.872882542416, 6494.318096599884, 6536.379043990813, 6553.279139294674, 6615.735370585123, 437.3046855499771, 450.40771385627795, 458.30337886413133, 460.64530311659837, 462.81256091283086, 4340.826366945287, 4438.822447102144, 4531.8187272509385, 4574.5425457453985, 4604.953950460453, 11640.0, 11850.229735067192, 12073.215241009482, 12260.386980650932, 12301.69245768845, 12035.157538972187, 12061.517539298506, 12072.275663460221, 12093.0, 12150.45322960469, 8870.600822962982, 8886.555672216364, 9048.728538143867, 9054.230390416888, 9054.411463254868, 6127.111568822585, 6164.537659675452, 6191.84520386994, 6221.813345599639, 6232.407921247474, 10912.61805836792, 11147.442627868737, 11166.1067114629, 11226.158038147008, 11307.717307067389, 11223.71940701489, 11391.715207119889, 11458.140639451907, 11529.884701153216, 11535.423228838692, 7805.102413222325, 8087.312578430664, 8260.793480163044, 8323.583820809057, 8588.184122508352, 9228.261739060725, 9415.340926135379, 9509.096635819586, 9516.524173791144, 9538.28462865274, 8163.102058773411, 8393.118722534291, 8396.244338009608, 8444.831103378021, 8620.827583448421, 8059.249820817093, 8173.468724532886, 8175.877361839696, 8208.630611622611, 8450.408471406943, 7369.042024536776, 7490.887636685345, 7749.845003100019, 7763.650635721293, 7914.564698941614, 5597.860053498533, 5631.267935168402, 5657.2928383952, 5736.139579063174, 5818.0981947798155, 5399.649022813504, 5420.512153906009, 5493.478119578634, 5506.669599824023, 5642.548596112383], "value": 4847.810671939059, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.20168591166413, 331.41836077683666, 339.4043453738689, 343.5516650770743, 347.953026341444, 5480.232767412561, 5524.171374293858, 5553.361363443205, 5565.972170139154, 5642.125470552071, 5486.862828429291, 5491.560675145989, 5510.421405752399, 5512.062949298619, 5533.750981205845, 4123.855665051724, 4303.698741088125, 4308.332208507686, 4338.154059958301, 4342.891427714301, 4251.978740106295, 4281.507626622932, 4295.19601767257, 4320.265554855682, 4336.132773445308, 4290.648445739597, 4291.721038132527, 4302.247106756321, 4314.460692413449, 4345.217860785057, 4059.451973983504, 4085.91723193354, 4225.154969006211, 4228.985043589516, 4231.851885184004, 3654.7441679082476, 3691.5201023866994, 3706.8331925063435, 3711.2206436648335, 3720.2931443025736, 5095.770690318907, 5235.476452354772, 5250.3962044364625, 5270.288511050997, 5270.947290527084, 4742.9525704742855, 4744.16977029022, 4769.642276829251, 4786.425628924517, 4809.831655892027, 5574.693391863446, 5624.156376543551, 5647.689377084259, 5652.576056795757, 5693.292012396265, 3998.10042740384, 4094.7338423002707, 4107.116969851467, 4146.4402305688645, 4153.91692166155, 5924.792632257893, 5935.228420305332, 5965.731542080617, 6010.308814486346, 6022.759089636409, 4170.416141740159, 4177.248095342807, 4201.642860356904, 4206.390073439334, 4206.41110244566, 4172.518755841693, 4229.788510574459, 4273.230818452708, 4280.700350975402, 4283.843362292164, 4827.879303017382, 4830.903381932341, 4839.516048395203, 4840.2255639097575, 4853.781579828846, 5737.799177028784, 5776.249087618667, 5790.971045144747, 5798.144593729966, 5808.128780682847, 1446.978295325571, 1486.524312220079, 1494.5665756930587, 1498.5803974887049, 1506.7664512000658, 935.3826474526779, 947.7346343023964, 949.4113649537331, 968.6222373274429, 975.4781192062212, 4923.335349727741, 4927.384076990376, 4929.0, 4956.4547899731, 4975.0, 5243.370795504564, 5270.235815806686, 5272.446393128743, 5274.7890084396195, 5281.287026251483, 4975.278584605212, 5329.600279978939, 5369.677819330853, 5608.46719561641, 5655.745491452894, 3134.5298205268937, 3141.403133404646, 3149.4960806270888, 3174.587303650511, 3187.8406079695924, 5879.235699359056, 6122.54080943931, 6184.5980011299125, 6199.659018753921, 6222.377762223832, 6060.42425969541, 6062.181605483203, 6086.786962456381, 6091.238595175603, 6095.969520152459, 6155.353687862799, 6192.956324412933, 6202.534809889186, 6218.968905155445, 6221.160143380676, 5695.857603559944, 5984.341722410619, 5993.280806303272, 6003.5797494174985, 6021.42796434338, 5859.007937301338, 5874.472637114295, 5923.0, 5958.612690175125, 5980.581359304807, 5857.853553661193, 6165.599236049642, 6171.537134715004, 6229.595076320024, 6274.74901003973, 4224.8732538023905, 4245.448091748053, 4263.872083837366, 4285.892852678708, 4287.249731296948, 6060.818175454743, 6080.48315893154, 6086.513078953762, 6138.631682099089, 6147.538934579835, 5648.209250704823, 5748.189320364072, 5797.594168408171, 5829.688320127937, 5843.532517398513, 5771.278590176228, 5797.507211887037, 5813.418658134153, 5830.212921255746, 5874.853128671817, 5445.482679145475, 5708.315002199763, 5714.542836572981, 5718.942810572007, 5725.799597014085, 5806.229100124503, 5808.273965754281, 5861.677607731445, 5871.354151043467, 5891.705414729161, 5512.944870551243, 5759.0, 5762.30852297727, 5771.105478650816, 5778.624389414675], "value": 4368.35065762886, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [767.7044337929896, 803.4255507312271, 855.5294587976612, 859.4284800607596, 896.3591032411827, 14542.127472351653, 15354.155521446315, 15420.922895385522, 15433.691326173484, 17033.82966170341, 16724.58188545284, 17586.0, 17704.0, 17722.46832595021, 17742.0, 720.6684924934536, 845.5772113943028, 880.106691707917, 885.5306687455659, 888.506878682331, 865.4071960706905, 880.5289170293894, 880.8150288439435, 880.9559522023873, 881.3610132653839, 926.8702381666573, 932.4312169576586, 933.0529512544772, 933.2067742418958, 933.2300851797295, 756.9583672897988, 892.9642814287486, 904.4663648447447, 926.0091701878993, 927.14702473724, 675.3651567526509, 676.0197713315663, 676.1750664189681, 676.2223443040493, 676.2966514824576, 16306.103164325958, 16450.341986320534, 16473.752893706605, 16485.17574121301, 16488.83511164885, 13747.518836840763, 13974.0, 14031.579052628438, 14039.78940315896, 14057.226852523107, 14111.78832317516, 14136.363863626162, 14516.419343226258, 14541.70916581673, 14574.927125364411, 4653.464851542082, 4680.742559159245, 4692.2257827458425, 4725.22033864412, 4746.0, 77749.8337524932, 77990.0, 78286.0, 78316.0, 79189.60405197938, 11938.820917686242, 11943.880561194277, 12095.153339266342, 12212.816807747891, 12236.0, 21053.57892842165, 21638.459038523848, 21749.456263593536, 21751.456213594785, 21791.673124902823, 9014.729558113268, 9386.953065234768, 9670.70987870365, 9688.612455501701, 9806.117449429586, 4977.278294647256, 5142.202958541432, 5209.4009188943, 5279.41926388097, 5285.207218917193, 4005.0387906902715, 4230.978845105817, 4305.677074219383, 4346.760928148982, 4350.847720329836, 605.1830029460282, 746.1493896957472, 748.7341993592305, 759.369723129801, 766.5439063757055, 679.6363945289246, 682.8804959132132, 735.8373769444265, 815.1278132398395, 818.6234332207132, 10476.790464190673, 10704.518296676668, 10742.140628749681, 10790.622328218475, 10845.13238940883, 631.66837410359, 718.392957950531, 752.9623518824037, 776.6082801756079, 795.7970717467125, 4934.383202099738, 5271.525562699376, 5291.735413229323, 5356.491133342326, 5390.51485366319, 74141.62929185427, 80413.0, 110897.44551277193, 122345.38827305807, 125218.0, 101778.0, 108969.0, 109472.0, 110253.0, 110454.0, 74120.0, 96239.51880240694, 96311.51844240734, 97667.0, 98069.50965245128, 9769.951150244204, 9861.260405469762, 10088.546015429176, 10150.289479736348, 10417.16662667, 55561.887052754246, 55969.720151398986, 56596.71701641465, 58322.12516812166, 59058.704706476194, 81411.59294203491, 81827.0, 82960.58519707363, 84019.15980840113, 84870.57564712137, 12553.560625378068, 12629.87370126287, 12868.806967895302, 12923.418446170133, 13254.0, 14730.631734206301, 15022.474213402478, 15340.0, 15418.46035388756, 15563.610909727347, 14839.332230049458, 15161.848381516043, 15165.469208577646, 15502.0, 16248.837511625205, 14539.200343981183, 14932.253387330373, 15107.54677359681, 15174.165420901514, 15187.08144954438, 14353.784693229401, 14722.705545888808, 14943.178125203218, 15033.548993530212, 15330.463433779763, 12226.20529665569, 12416.192947458387, 12623.558175463815, 12701.174423662433, 13113.606591802261, 11140.164487663296, 11881.821772673244, 12240.75518489643, 12335.50657973671, 12440.00479961619], "value": 8171.908075631829, "unit": "score"}], "name": "dromaeo_css", "value": 7622.659344978385, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 106.0, 108.0, 108.0, 110.0, 110.0, 108.0, 110.0, 109.0, 110.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 124.0, 130.0, 178.0, 123.0, 126.0, 153.0, 125.0, 166.0, 124.0], "value": 140.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 159.0, 161.0, 161.0, 162.0, 161.0, 160.0, 160.0, 160.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 76.0, 120.0, 75.0, 77.0, 73.0, 75.0, 98.0, 75.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 110.0, 85.0, 86.0, 84.0, 110.0, 86.0, 84.0, 129.0], "value": 94.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 147.0, 147.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 97.0, 94.0, 95.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 51.0, 52.0, 53.0, 52.0, 54.0, 53.0, 51.0, 52.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 61.0, 58.0, 58.0, 59.0, 59.0, 59.0, 59.0, 58.0, 59.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 76.0, 82.0, 81.0, 80.0, 77.0, 77.0, 110.0, 77.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 118.0, 121.0, 127.0, 117.0, 131.0, 141.0, 123.0, 128.0], "value": 124.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 159.0, 152.0, 152.0, 151.0, 155.0, 154.0, 153.0, 157.0, 153.0], "value": 154.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 65.0, 61.0, 60.0, 61.0, 61.0, 62.0, 61.0, 61.0, 59.0], "value": 61.2, "unit": "score"}], "name": "kraken", "value": 1475.8000000000002, "alertThreshold": 2.0}]} 03:55:31 INFO - Return code: 0 03:55:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:55:31 ERROR - # TBPL SUCCESS # 03:55:31 INFO - Running post-action listener: _resource_record_post_action 03:55:31 INFO - ##### 03:55:31 INFO - ##### Finished run-tests step (success) 03:55:31 INFO - ##### 03:55:31 INFO - Running post-run listener: _resource_record_post_run 03:55:31 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 505389056; Read time: 20; Write time: 501348 03:55:31 INFO - TinderboxPrint: CPU usage
13.1% 03:55:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 03:55:31 INFO - TinderboxPrint: I/O write bytes / time
505,389,056 / 501,348 03:55:31 INFO - TinderboxPrint: CPU idle
8,255.9 (86.9%) 03:55:31 INFO - TinderboxPrint: CPU user
1,196.6 (12.6%) 03:55:31 INFO - TinderboxPrint: Swap in / out
0 / 0 03:55:31 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 149110784; Read time: 0; Write time: 210208 03:55:31 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 252760064; Read time: 20; Write time: 191124 03:55:32 INFO - Running post-run listener: _upload_blobber_files 03:55:32 INFO - Blob upload gear active. 03:55:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:55:32 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 03:55:32 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'] 03:55:32 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 03:55:32 INFO - (blobuploader) - INFO - Open directory for files ... 03:55:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:55:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:55:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:33 INFO - (blobuploader) - INFO - Done attempting. 03:55:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:55:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:55:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:34 INFO - (blobuploader) - INFO - Done attempting. 03:55:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:55:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:55:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:37 INFO - (blobuploader) - INFO - Done attempting. 03:55:37 INFO - (blobuploader) - INFO - Iteration through files over. 03:55:37 INFO - Return code: 0 03:55:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:55:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:55:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4209ad9b1c0c95caf27dcc0e8554c3d6614dc68ff42a2836a2d8ce548a3f961394ef5474057d96dfe5900c64cd4133b489f28a21a69bda9325c0d19cd84f8f48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f3fb40936bddcb1a202c2a60a3419ab824d23f30cbb09cad8c4a0dafcbdb7f9fe822bbea0c4296efde3123e0ec0e3abcfa6bd779ae328a0a6c255c0fdb43fa4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd77a216e3a32e59205164e551236422288aae16f4ef054fee4026181326d78c3dea51073815c3674e2b7727e89159a4121be25d49c22d29b592999b44156125"} 03:55:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:55:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:55:37 INFO - Contents: 03:55:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4209ad9b1c0c95caf27dcc0e8554c3d6614dc68ff42a2836a2d8ce548a3f961394ef5474057d96dfe5900c64cd4133b489f28a21a69bda9325c0d19cd84f8f48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f3fb40936bddcb1a202c2a60a3419ab824d23f30cbb09cad8c4a0dafcbdb7f9fe822bbea0c4296efde3123e0ec0e3abcfa6bd779ae328a0a6c255c0fdb43fa4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd77a216e3a32e59205164e551236422288aae16f4ef054fee4026181326d78c3dea51073815c3674e2b7727e89159a4121be25d49c22d29b592999b44156125"} 03:55:37 INFO - Running post-run listener: copy_logs_to_upload_dir 03:55:37 INFO - Copying logs to upload dir... 03:55:37 INFO - mkdir: /builds/slave/test/build/upload/logs 03:55:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.833246 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-03 03:55:37.174618) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-03 03:55:37.182040) ========= 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=14ef55db36f7623abb31b9cf000001d5-1467541942.376890-256204262 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/4209ad9b1c0c95caf27dcc0e8554c3d6614dc68ff42a2836a2d8ce548a3f961394ef5474057d96dfe5900c64cd4133b489f28a21a69bda9325c0d19cd84f8f48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f3fb40936bddcb1a202c2a60a3419ab824d23f30cbb09cad8c4a0dafcbdb7f9fe822bbea0c4296efde3123e0ec0e3abcfa6bd779ae328a0a6c255c0fdb43fa4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd77a216e3a32e59205164e551236422288aae16f4ef054fee4026181326d78c3dea51073815c3674e2b7727e89159a4121be25d49c22d29b592999b44156125"} build_url:https://queue.taskcluster.net/v1/task/ByaYG22TSOi3QRl31uNTTw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011246 build_url: 'https://queue.taskcluster.net/v1/task/ByaYG22TSOi3QRl31uNTTw/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/4209ad9b1c0c95caf27dcc0e8554c3d6614dc68ff42a2836a2d8ce548a3f961394ef5474057d96dfe5900c64cd4133b489f28a21a69bda9325c0d19cd84f8f48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f3fb40936bddcb1a202c2a60a3419ab824d23f30cbb09cad8c4a0dafcbdb7f9fe822bbea0c4296efde3123e0ec0e3abcfa6bd779ae328a0a6c255c0fdb43fa4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd77a216e3a32e59205164e551236422288aae16f4ef054fee4026181326d78c3dea51073815c3674e2b7727e89159a4121be25d49c22d29b592999b44156125"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-03 03:55:37.210861) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:55:37.211261) ========= 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=14ef55db36f7623abb31b9cf000001d5-1467541942.376890-256204262 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004418 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:55:37.291428) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-03 03:55:37.295012) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-03 03:55:37.295536) ========= ========= Total master_lag: 0.19 =========