builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-043 starttime: 1467101917.78 results: success (0) buildid: 20160627130921 builduid: a6b74d1bbac54478809dc3da76fbdb0f revision: f20f82876561686c4f8a619a0e1baa9f58261e0f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:37.781176) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:37.781588) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:37.781856) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:38.707336) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:38.707735) ========= 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=d2a8c569965ab8367867b893000001a1-1467101506.332576-40929488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-28 01:18:39-- 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% 42.9M=0s 2016-06-28 01:18:39 (42.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091777 ========= master_lag: 0.56 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:39.356020) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:39.356311) ========= 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=d2a8c569965ab8367867b893000001a1-1467101506.332576-40929488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023320 ========= master_lag: 0.21 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:39.591704) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:39.592046) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f20f82876561686c4f8a619a0e1baa9f58261e0f --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 f20f82876561686c4f8a619a0e1baa9f58261e0f --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=d2a8c569965ab8367867b893000001a1-1467101506.332576-40929488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-28 01:18:40,181 truncating revision to first 12 chars 2016-06-28 01:18:40,181 Setting DEBUG logging. 2016-06-28 01:18:40,182 attempt 1/10 2016-06-28 01:18:40,182 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f20f82876561?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 01:18:40,489 unpacking tar archive at: mozilla-aurora-f20f82876561/testing/mozharness/ program finished with exit code 0 elapsedTime=0.642087 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:40.309911) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:40.310202) ========= script_repo_revision: f20f82876561686c4f8a619a0e1baa9f58261e0f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:40.316707) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:40.317033) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 01:18:40.407461) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-28 01:18:40.407778) ========= /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=d2a8c569965ab8367867b893000001a1-1467101506.332576-40929488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:18:41 INFO - MultiFileLogger online at 20160628 01:18:41 in /builds/slave/test 01:18:41 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 01:18:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:18:41 INFO - {'append_to_log': False, 01:18:41 INFO - 'base_work_dir': '/builds/slave/test', 01:18:41 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:18:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:18:41 INFO - 'branch': 'Mozilla-Aurora', 01:18:41 INFO - 'buildbot_json_path': 'buildprops.json', 01:18:41 INFO - 'config_files': ('talos/linux_config.py',), 01:18:41 INFO - 'default_actions': ('clobber', 01:18:41 INFO - 'read-buildbot-config', 01:18:41 INFO - 'download-and-extract', 01:18:41 INFO - 'populate-webroot', 01:18:41 INFO - 'create-virtualenv', 01:18:41 INFO - 'install', 01:18:41 INFO - 'run-tests'), 01:18:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:18:41 INFO - 'download_minidump_stackwalk': True, 01:18:41 INFO - 'download_symbols': 'ondemand', 01:18:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:18:41 INFO - 'tooltool.py': '/tools/tooltool.py', 01:18:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:18:41 INFO - '/tools/misc-python/virtualenv.py')}, 01:18:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:18:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:18:41 INFO - 'installer_path': 'installer.exe', 01:18:41 INFO - 'log_level': 'info', 01:18:41 INFO - 'log_name': 'talos', 01:18:41 INFO - 'log_to_console': True, 01:18:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:18:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:18:41 INFO - 'opt_config_files': (), 01:18:41 INFO - 'pip_index': False, 01:18:41 INFO - 'sps_profile': False, 01:18:41 INFO - 'sps_profile_interval': 0, 01:18:41 INFO - 'suite': 'dromaeojs', 01:18:41 INFO - 'system_bits': '32', 01:18:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:18:41 INFO - 'title': 'talos-linux64-ix-043', 01:18:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:18:41 INFO - 'use_talos_json': True, 01:18:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:18:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:18:41 INFO - 'work_dir': 'build'} 01:18:41 INFO - ##### 01:18:41 INFO - ##### Running clobber step. 01:18:41 INFO - ##### 01:18:41 INFO - Running pre-action listener: _resource_record_pre_action 01:18:41 INFO - Running main action method: clobber 01:18:41 INFO - rmtree: /builds/slave/test/build 01:18:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:18:41 INFO - Running post-action listener: _resource_record_post_action 01:18:41 INFO - ##### 01:18:41 INFO - ##### Finished clobber step (success) 01:18:41 INFO - ##### 01:18:41 INFO - ##### 01:18:41 INFO - ##### Running read-buildbot-config step. 01:18:41 INFO - ##### 01:18:41 INFO - Running pre-action listener: _resource_record_pre_action 01:18:41 INFO - Running main action method: read_buildbot_config 01:18:41 INFO - Using buildbot properties: 01:18:41 INFO - { 01:18:41 INFO - "project": "", 01:18:41 INFO - "product": "firefox", 01:18:41 INFO - "script_repo_revision": "production", 01:18:41 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 01:18:41 INFO - "repository": "", 01:18:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 01:18:41 INFO - "buildid": "20160627130921", 01:18:41 INFO - "pgo_build": "True", 01:18:41 INFO - "basedir": "/builds/slave/test", 01:18:41 INFO - "buildnumber": 323, 01:18:41 INFO - "slavename": "talos-linux64-ix-043", 01:18:41 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:18:41 INFO - "platform": "ubuntu64_hw", 01:18:41 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 01:18:41 INFO - "branch": "mozilla-aurora", 01:18:41 INFO - "repo_path": "releases/mozilla-aurora", 01:18:41 INFO - "revision": "f20f82876561686c4f8a619a0e1baa9f58261e0f", 01:18:41 INFO - "stage_platform": "linux64-pgo", 01:18:41 INFO - "builduid": "a6b74d1bbac54478809dc3da76fbdb0f", 01:18:41 INFO - "slavebuilddir": "test" 01:18:41 INFO - } 01:18:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 01:18:41 INFO - Running post-action listener: _resource_record_post_action 01:18:41 INFO - ##### 01:18:41 INFO - ##### Finished read-buildbot-config step (success) 01:18:41 INFO - ##### 01:18:41 INFO - ##### 01:18:41 INFO - ##### Running download-and-extract step. 01:18:41 INFO - ##### 01:18:41 INFO - Running pre-action listener: _resource_record_pre_action 01:18:41 INFO - Running main action method: download_and_extract 01:18:41 INFO - mkdir: /builds/slave/test/build/tests 01:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:18:41 INFO - https://queue.taskcluster.net/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:18:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 01:18:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 01:18:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/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 01:18:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/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 01:18:43 INFO - Downloaded 1361 bytes. 01:18:43 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 01:18:43 INFO - Using the following test package requirements: 01:18:43 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 01:18:43 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:18:43 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 01:18:43 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:18:43 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 01:18:43 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:18:43 INFO - u'jsshell-linux-x86_64.zip'], 01:18:43 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:18:43 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 01:18:43 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 01:18:43 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:18:43 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 01:18:43 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:18:43 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 01:18:43 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:18:43 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 01:18:43 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:18:43 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 01:18:43 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:18:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:18:43 INFO - https://queue.taskcluster.net/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:18:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 01:18:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 01:18:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/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 01:18:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/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 01:18:44 INFO - Downloaded 24525033 bytes. 01:18:44 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'] 01:18:44 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 01:18:45 INFO - Return code: 0 01:18:45 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 01:18:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:18:45 INFO - https://queue.taskcluster.net/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:18:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 01:18:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 01:18:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/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 01:18:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/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 01:18:49 INFO - Downloaded 24525033 bytes. 01:18:49 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'] 01:18:49 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 01:18:51 INFO - Return code: 0 01:18:51 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')]} 01:18:51 INFO - https://queue.taskcluster.net/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:18:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 01:18:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 01:18:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/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 01:18:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/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 01:18:52 INFO - Downloaded 10833369 bytes. 01:18:52 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'] 01:18:52 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 01:18:52 INFO - Return code: 0 01:18:52 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')]} 01:18:52 INFO - https://queue.taskcluster.net/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:18:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 01:18:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 01:18:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/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 01:18:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/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 01:18:59 INFO - Downloaded 63614591 bytes. 01:18:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 01:18:59 INFO - mkdir: /builds/slave/test/properties 01:18:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:18:59 INFO - Writing to file /builds/slave/test/properties/build_url 01:18:59 INFO - Contents: 01:18:59 INFO - build_url:https://queue.taskcluster.net/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 01:18:59 INFO - Running post-action listener: _resource_record_post_action 01:18:59 INFO - Running post-action listener: set_extra_try_arguments 01:18:59 INFO - ##### 01:18:59 INFO - ##### Finished download-and-extract step (success) 01:18:59 INFO - ##### 01:18:59 INFO - ##### 01:18:59 INFO - ##### Running populate-webroot step. 01:18:59 INFO - ##### 01:18:59 INFO - Running pre-action listener: _resource_record_pre_action 01:18:59 INFO - Running main action method: populate_webroot 01:18:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:18:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:18:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:18:59 INFO - '--tppagecycles', 01:18:59 INFO - '7'], 01:18:59 INFO - 'tests': ['tsvgm']}}, 01:18:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:18:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:18:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:18:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:18:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:18:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:18:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:18:59 INFO - 'talos_options': ['--disable-e10s'], 01:18:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:18:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:18:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:18:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:18:59 INFO - 'talos_options': ['--disable-e10s'], 01:18:59 INFO - 'tests': ['damp', 'tps']}, 01:18:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:18:59 INFO - 'tests': ['damp', 'tps']}, 01:18:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:18:59 INFO - 'tests': ['dromaeo_dom']}, 01:18:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:18:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:18:59 INFO - 'tests': ['a11yr', 01:18:59 INFO - 'ts_paint', 01:18:59 INFO - 'tpaint', 01:18:59 INFO - 'sessionrestore', 01:18:59 INFO - 'sessionrestore_no_auto_restore', 01:18:59 INFO - 'tabpaint']}, 01:18:59 INFO - 'other-e10s': {'tests': ['a11yr', 01:18:59 INFO - 'ts_paint', 01:18:59 INFO - 'tpaint', 01:18:59 INFO - 'sessionrestore', 01:18:59 INFO - 'sessionrestore_no_auto_restore', 01:18:59 INFO - 'tabpaint']}, 01:18:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:18:59 INFO - 'ts_paint', 01:18:59 INFO - 'tpaint', 01:18:59 INFO - 'sessionrestore', 01:18:59 INFO - 'sessionrestore_no_auto_restore', 01:18:59 INFO - 'tabpaint']}, 01:18:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:18:59 INFO - 'ts_paint', 01:18:59 INFO - 'tpaint', 01:18:59 INFO - 'sessionrestore', 01:18:59 INFO - 'sessionrestore_no_auto_restore', 01:18:59 INFO - 'tabpaint']}, 01:18:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:18:59 INFO - 'tests': ['a11yr', 01:18:59 INFO - 'ts_paint', 01:18:59 INFO - 'tpaint', 01:18:59 INFO - 'sessionrestore', 01:18:59 INFO - 'sessionrestore_no_auto_restore', 01:18:59 INFO - 'tabpaint']}, 01:18:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:18:59 INFO - 'tests': ['a11yr', 01:18:59 INFO - 'ts_paint', 01:18:59 INFO - 'tpaint', 01:18:59 INFO - 'sessionrestore', 01:18:59 INFO - 'sessionrestore_no_auto_restore', 01:18:59 INFO - 'tabpaint']}, 01:18:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:18:59 INFO - 'tests': ['tsvgx', 01:18:59 INFO - 'tsvgr_opacity', 01:18:59 INFO - 'tart', 01:18:59 INFO - 'tscrollx', 01:18:59 INFO - 'cart']}, 01:18:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:18:59 INFO - 'tsvgr_opacity', 01:18:59 INFO - 'tart', 01:18:59 INFO - 'tscrollx', 01:18:59 INFO - 'cart']}, 01:18:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:18:59 INFO - 'talos_options': ['--disable-e10s'], 01:18:59 INFO - 'tests': ['tp5o']}, 01:18:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:18:59 INFO - 'tests': ['tp5o']}, 01:18:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:18:59 INFO - 'talos_options': ['--disable-e10s', 01:18:59 INFO - '--xperf_path', 01:18:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:18:59 INFO - 'tests': ['tp5n']}, 01:18:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:18:59 INFO - 'talos_options': ['--xperf_path', 01:18:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:18:59 INFO - 'tests': ['tp5n']}}, 01:18:59 INFO - 'talos.zip': {'path': '', 01:18:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:18:59 INFO - Running post-action listener: _resource_record_post_action 01:18:59 INFO - ##### 01:18:59 INFO - ##### Finished populate-webroot step (success) 01:18:59 INFO - ##### 01:18:59 INFO - ##### 01:18:59 INFO - ##### Running create-virtualenv step. 01:18:59 INFO - ##### 01:18:59 INFO - Running pre-action listener: _resource_record_pre_action 01:18:59 INFO - Running main action method: create_virtualenv 01:18:59 INFO - Creating virtualenv /builds/slave/test/build/venv 01:18:59 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 01:18:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:18:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:18:59 INFO - Using real prefix '/usr' 01:18:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:19:00 INFO - Installing distribute.............................................................................................................................................................................................done. 01:19:02 INFO - Installing pip.................done. 01:19:02 INFO - Return code: 0 01:19:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f41f94d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2075450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21042c0>, '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 0x21051c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2105650>, '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': 'd2a8c569965ab8367867b893000001a1-1467101506.332576-40929488', '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 01:19:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:19:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:19:02 INFO - Using env: {'DISPLAY': ':0', 01:19:02 INFO - 'HOME': '/home/cltbld', 01:19:02 INFO - 'LANG': 'en_US.UTF-8', 01:19:02 INFO - 'LANGUAGE': 'en_US:en', 01:19:02 INFO - 'LOGNAME': 'cltbld', 01:19:02 INFO - 'MAIL': '/var/mail/cltbld', 01:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:02 INFO - 'MOZ_NO_REMOTE': '1', 01:19:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:02 INFO - 'NO_EM_RESTART': '1', 01:19:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:02 INFO - 'PWD': '/builds/slave/test', 01:19:02 INFO - 'SHELL': '/bin/bash', 01:19:02 INFO - 'SHLVL': '1', 01:19:02 INFO - 'TERM': 'linux', 01:19:02 INFO - 'TMOUT': '86400', 01:19:02 INFO - 'USER': 'cltbld', 01:19:02 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467101506.332576-40929488', 01:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:02 INFO - '_': '/tools/buildbot/bin/python'} 01:19:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:02 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 01:19:02 INFO - Cleaning up... 01:19:02 INFO - Return code: 0 01:19:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f41f94d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2075450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21042c0>, '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 0x21051c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2105650>, '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': 'd2a8c569965ab8367867b893000001a1-1467101506.332576-40929488', '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 01:19:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:19:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:19:02 INFO - Using env: {'DISPLAY': ':0', 01:19:02 INFO - 'HOME': '/home/cltbld', 01:19:02 INFO - 'LANG': 'en_US.UTF-8', 01:19:02 INFO - 'LANGUAGE': 'en_US:en', 01:19:02 INFO - 'LOGNAME': 'cltbld', 01:19:02 INFO - 'MAIL': '/var/mail/cltbld', 01:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:02 INFO - 'MOZ_NO_REMOTE': '1', 01:19:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:02 INFO - 'NO_EM_RESTART': '1', 01:19:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:02 INFO - 'PWD': '/builds/slave/test', 01:19:02 INFO - 'SHELL': '/bin/bash', 01:19:02 INFO - 'SHLVL': '1', 01:19:02 INFO - 'TERM': 'linux', 01:19:02 INFO - 'TMOUT': '86400', 01:19:02 INFO - 'USER': 'cltbld', 01:19:02 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467101506.332576-40929488', 01:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:02 INFO - '_': '/tools/buildbot/bin/python'} 01:19:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:02 INFO - Downloading/unpacking psutil>=3.1.1 01:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:19:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:19:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:19:04 INFO - Installing collected packages: psutil 01:19:04 INFO - Running setup.py install for psutil 01:19:04 INFO - building 'psutil._psutil_linux' extension 01:19:04 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 01:19:05 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 01:19:05 INFO - building 'psutil._psutil_posix' extension 01:19:05 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 01:19:05 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 01:19:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:19:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:19:05 INFO - Successfully installed psutil 01:19:05 INFO - Cleaning up... 01:19:05 INFO - Return code: 0 01:19:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f41f94d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2075450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21042c0>, '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 0x21051c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2105650>, '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': 'd2a8c569965ab8367867b893000001a1-1467101506.332576-40929488', '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 01:19:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:19:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:19:05 INFO - Using env: {'DISPLAY': ':0', 01:19:05 INFO - 'HOME': '/home/cltbld', 01:19:05 INFO - 'LANG': 'en_US.UTF-8', 01:19:05 INFO - 'LANGUAGE': 'en_US:en', 01:19:05 INFO - 'LOGNAME': 'cltbld', 01:19:05 INFO - 'MAIL': '/var/mail/cltbld', 01:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:05 INFO - 'MOZ_NO_REMOTE': '1', 01:19:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:05 INFO - 'NO_EM_RESTART': '1', 01:19:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:05 INFO - 'PWD': '/builds/slave/test', 01:19:05 INFO - 'SHELL': '/bin/bash', 01:19:05 INFO - 'SHLVL': '1', 01:19:05 INFO - 'TERM': 'linux', 01:19:05 INFO - 'TMOUT': '86400', 01:19:05 INFO - 'USER': 'cltbld', 01:19:05 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467101506.332576-40929488', 01:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:05 INFO - '_': '/tools/buildbot/bin/python'} 01:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:19:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:19:07 INFO - Installing collected packages: mozsystemmonitor 01:19:07 INFO - Running setup.py install for mozsystemmonitor 01:19:07 INFO - Successfully installed mozsystemmonitor 01:19:07 INFO - Cleaning up... 01:19:07 INFO - Return code: 0 01:19:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:19:07 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')]} 01:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:07 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')]} 01:19:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:07 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 0x7f41f94d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2075450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21042c0>, '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 0x21051c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2105650>, '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': 'd2a8c569965ab8367867b893000001a1-1467101506.332576-40929488', '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 01:19:07 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 01:19:07 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 01:19:07 INFO - Using env: {'DISPLAY': ':0', 01:19:07 INFO - 'HOME': '/home/cltbld', 01:19:07 INFO - 'LANG': 'en_US.UTF-8', 01:19:07 INFO - 'LANGUAGE': 'en_US:en', 01:19:07 INFO - 'LOGNAME': 'cltbld', 01:19:07 INFO - 'MAIL': '/var/mail/cltbld', 01:19:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:07 INFO - 'MOZ_NO_REMOTE': '1', 01:19:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:07 INFO - 'NO_EM_RESTART': '1', 01:19:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:07 INFO - 'PWD': '/builds/slave/test', 01:19:07 INFO - 'SHELL': '/bin/bash', 01:19:07 INFO - 'SHLVL': '1', 01:19:07 INFO - 'TERM': 'linux', 01:19:07 INFO - 'TMOUT': '86400', 01:19:07 INFO - 'USER': 'cltbld', 01:19:07 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467101506.332576-40929488', 01:19:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:07 INFO - '_': '/tools/buildbot/bin/python'} 01:19:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:07 INFO - Downloading/unpacking jsonschema==2.5.1 01:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:19:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:19:09 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 01:19:09 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 01:19:09 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 01:19:09 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 01:19:09 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 01:19:09 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 01:19:10 INFO - Downloading functools32-3.2.3-2.tar.gz 01:19:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:19:10 INFO - warning: no files found matching '*.txt' 01:19:10 INFO - no previously-included directories found matching 'build' 01:19:10 INFO - no previously-included directories found matching 'dist' 01:19:10 INFO - no previously-included directories found matching '.git*' 01:19:10 INFO - Installing collected packages: jsonschema, functools32 01:19:10 INFO - Running setup.py install for functools32 01:19:10 INFO - warning: no files found matching '*.txt' 01:19:10 INFO - no previously-included directories found matching 'build' 01:19:10 INFO - no previously-included directories found matching 'dist' 01:19:10 INFO - no previously-included directories found matching '.git*' 01:19:10 INFO - Successfully installed jsonschema functools32 01:19:10 INFO - Cleaning up... 01:19:10 INFO - Return code: 0 01:19:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:19:10 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')]} 01:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:10 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')]} 01:19:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:10 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 0x7f41f94d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2075450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21042c0>, '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 0x21051c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2105650>, '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': 'd2a8c569965ab8367867b893000001a1-1467101506.332576-40929488', '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 01:19:10 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 01:19:10 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 01:19:10 INFO - Using env: {'DISPLAY': ':0', 01:19:10 INFO - 'HOME': '/home/cltbld', 01:19:10 INFO - 'LANG': 'en_US.UTF-8', 01:19:10 INFO - 'LANGUAGE': 'en_US:en', 01:19:10 INFO - 'LOGNAME': 'cltbld', 01:19:10 INFO - 'MAIL': '/var/mail/cltbld', 01:19:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:10 INFO - 'MOZ_NO_REMOTE': '1', 01:19:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:10 INFO - 'NO_EM_RESTART': '1', 01:19:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:10 INFO - 'PWD': '/builds/slave/test', 01:19:10 INFO - 'SHELL': '/bin/bash', 01:19:10 INFO - 'SHLVL': '1', 01:19:10 INFO - 'TERM': 'linux', 01:19:10 INFO - 'TMOUT': '86400', 01:19:10 INFO - 'USER': 'cltbld', 01:19:10 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467101506.332576-40929488', 01:19:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:10 INFO - '_': '/tools/buildbot/bin/python'} 01:19:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:10 INFO - Downloading/unpacking blobuploader==1.2.4 01:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:12 INFO - Downloading blobuploader-1.2.4.tar.gz 01:19:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:19:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:19:12 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 01:19:12 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 01:19:12 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 01:19:12 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 01:19:12 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 01:19:12 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 01:19:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:19:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:13 INFO - Downloading docopt-0.6.1.tar.gz 01:19:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:19:13 INFO - Installing collected packages: blobuploader, requests, docopt 01:19:13 INFO - Running setup.py install for blobuploader 01:19:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:19:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:19:13 INFO - Running setup.py install for requests 01:19:13 INFO - Running setup.py install for docopt 01:19:13 INFO - Successfully installed blobuploader requests docopt 01:19:13 INFO - Cleaning up... 01:19:14 INFO - Return code: 0 01:19:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:19:14 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')]} 01:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:14 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')]} 01:19:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:14 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 0x7f41f94d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2075450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21042c0>, '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 0x21051c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2105650>, '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': 'd2a8c569965ab8367867b893000001a1-1467101506.332576-40929488', '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 01:19:14 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 01:19:14 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 01:19:14 INFO - Using env: {'DISPLAY': ':0', 01:19:14 INFO - 'HOME': '/home/cltbld', 01:19:14 INFO - 'LANG': 'en_US.UTF-8', 01:19:14 INFO - 'LANGUAGE': 'en_US:en', 01:19:14 INFO - 'LOGNAME': 'cltbld', 01:19:14 INFO - 'MAIL': '/var/mail/cltbld', 01:19:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:14 INFO - 'MOZ_NO_REMOTE': '1', 01:19:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:14 INFO - 'NO_EM_RESTART': '1', 01:19:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:14 INFO - 'PWD': '/builds/slave/test', 01:19:14 INFO - 'SHELL': '/bin/bash', 01:19:14 INFO - 'SHLVL': '1', 01:19:14 INFO - 'TERM': 'linux', 01:19:14 INFO - 'TMOUT': '86400', 01:19:14 INFO - 'USER': 'cltbld', 01:19:14 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467101506.332576-40929488', 01:19:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:14 INFO - '_': '/tools/buildbot/bin/python'} 01:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:19:14 INFO - Running setup.py (path:/tmp/pip-dPf3zh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:19:14 INFO - Running setup.py (path:/tmp/pip-wl6qsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:19:14 INFO - Running setup.py (path:/tmp/pip-gI6bYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:19:14 INFO - Running setup.py (path:/tmp/pip-5hqc2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:19:14 INFO - Running setup.py (path:/tmp/pip-fu0n6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:19:14 INFO - Running setup.py (path:/tmp/pip-X1pqdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:19:14 INFO - Running setup.py (path:/tmp/pip-9Zff8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:19:14 INFO - Running setup.py (path:/tmp/pip-dxNcZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:19:14 INFO - Running setup.py (path:/tmp/pip-GWUJdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:19:14 INFO - Running setup.py (path:/tmp/pip-R6idrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:19:14 INFO - Running setup.py (path:/tmp/pip-mJAh5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:19:15 INFO - Running setup.py (path:/tmp/pip-Homwi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:19:15 INFO - Running setup.py (path:/tmp/pip-JKD9EM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:19:15 INFO - Running setup.py (path:/tmp/pip-fTETyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:19:15 INFO - Running setup.py (path:/tmp/pip-cLyE8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:19:15 INFO - Running setup.py (path:/tmp/pip-IwRTSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:19:15 INFO - Running setup.py (path:/tmp/pip-4iNVU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:19:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:19:15 INFO - Running setup.py install for manifestparser 01:19:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:19:15 INFO - Running setup.py install for mozcrash 01:19:15 INFO - Running setup.py install for mozdebug 01:19:15 INFO - Running setup.py install for mozdevice 01:19:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:19:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:19:15 INFO - Running setup.py install for mozfile 01:19:15 INFO - Running setup.py install for mozhttpd 01:19:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:19:16 INFO - Running setup.py install for mozinfo 01:19:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:19:16 INFO - Running setup.py install for mozInstall 01:19:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:19:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:19:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:19:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:19:16 INFO - Running setup.py install for mozleak 01:19:16 INFO - Running setup.py install for mozlog 01:19:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:19:16 INFO - Running setup.py install for moznetwork 01:19:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:19:16 INFO - Running setup.py install for mozprocess 01:19:16 INFO - Running setup.py install for mozprofile 01:19:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:19:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:19:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:19:16 INFO - Running setup.py install for mozrunner 01:19:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:19:16 INFO - Running setup.py install for mozscreenshot 01:19:17 INFO - Running setup.py install for moztest 01:19:17 INFO - Running setup.py install for mozversion 01:19:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:19:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:19:17 INFO - Cleaning up... 01:19:17 INFO - Return code: 0 01:19:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:19:17 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')]} 01:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:17 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')]} 01:19:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:17 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 0x7f41f94d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2075450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21042c0>, '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 0x21051c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2105650>, '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': 'd2a8c569965ab8367867b893000001a1-1467101506.332576-40929488', '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 01:19:17 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 01:19:17 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 01:19:17 INFO - Using env: {'DISPLAY': ':0', 01:19:17 INFO - 'HOME': '/home/cltbld', 01:19:17 INFO - 'LANG': 'en_US.UTF-8', 01:19:17 INFO - 'LANGUAGE': 'en_US:en', 01:19:17 INFO - 'LOGNAME': 'cltbld', 01:19:17 INFO - 'MAIL': '/var/mail/cltbld', 01:19:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:17 INFO - 'MOZ_NO_REMOTE': '1', 01:19:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:17 INFO - 'NO_EM_RESTART': '1', 01:19:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:17 INFO - 'PWD': '/builds/slave/test', 01:19:17 INFO - 'SHELL': '/bin/bash', 01:19:17 INFO - 'SHLVL': '1', 01:19:17 INFO - 'TERM': 'linux', 01:19:17 INFO - 'TMOUT': '86400', 01:19:17 INFO - 'USER': 'cltbld', 01:19:17 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467101506.332576-40929488', 01:19:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:17 INFO - '_': '/tools/buildbot/bin/python'} 01:19:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:19:17 INFO - Running setup.py (path:/tmp/pip-q7vTDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:19:17 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)) 01:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:19:17 INFO - Running setup.py (path:/tmp/pip-HctRGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:19:17 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)) 01:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:19:17 INFO - Running setup.py (path:/tmp/pip-0YdZY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:19:17 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)) 01:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:19:17 INFO - Running setup.py (path:/tmp/pip-fQt4ks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:19:17 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)) 01:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:19:17 INFO - Running setup.py (path:/tmp/pip-GtbEBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:19:17 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)) 01:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:19:17 INFO - Running setup.py (path:/tmp/pip-v9q3f1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:19:17 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)) 01:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:19:17 INFO - Running setup.py (path:/tmp/pip-j643Ly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:19:17 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)) 01:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:19:17 INFO - Running setup.py (path:/tmp/pip-9syb7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:19:18 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)) 01:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:19:18 INFO - Running setup.py (path:/tmp/pip-dxlXYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:19:18 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)) 01:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:19:18 INFO - Running setup.py (path:/tmp/pip-V_L8s_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:19:18 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)) 01:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:19:18 INFO - Running setup.py (path:/tmp/pip-Mdv9cl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:19:18 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)) 01:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:19:18 INFO - Running setup.py (path:/tmp/pip-7Tn_k3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:19:18 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)) 01:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:19:18 INFO - Running setup.py (path:/tmp/pip-N9WHxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:19:18 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)) 01:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:19:18 INFO - Running setup.py (path:/tmp/pip-Ur_bQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:19:18 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)) 01:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:19:18 INFO - Running setup.py (path:/tmp/pip-AslqZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:19:18 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)) 01:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:19:18 INFO - Running setup.py (path:/tmp/pip-5nO8K6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:19:18 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)) 01:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:19:18 INFO - Running setup.py (path:/tmp/pip-5UvuG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:19:18 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)) 01:19:18 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)) 01:19:18 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)) 01:19:18 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)) 01:19:18 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)) 01:19:18 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)) 01:19:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:20 INFO - Downloading blessings-1.6.tar.gz 01:19:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:19:20 INFO - Installing collected packages: blessings 01:19:20 INFO - Running setup.py install for blessings 01:19:20 INFO - Successfully installed blessings 01:19:20 INFO - Cleaning up... 01:19:20 INFO - Return code: 0 01:19:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:19:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:19:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:19:21 INFO - Reading from file tmpfile_stdout 01:19:21 INFO - Current package versions: 01:19:21 INFO - argparse == 1.2.1 01:19:21 INFO - blessings == 1.6 01:19:21 INFO - blobuploader == 1.2.4 01:19:21 INFO - docopt == 0.6.1 01:19:21 INFO - functools32 == 3.2.3-2 01:19:21 INFO - jsonschema == 2.5.1 01:19:21 INFO - manifestparser == 1.1 01:19:21 INFO - mozInstall == 1.12 01:19:21 INFO - mozcrash == 0.17 01:19:21 INFO - mozdebug == 0.1 01:19:21 INFO - mozdevice == 0.48 01:19:21 INFO - mozfile == 1.2 01:19:21 INFO - mozhttpd == 0.7 01:19:21 INFO - mozinfo == 0.9 01:19:21 INFO - mozleak == 0.1 01:19:21 INFO - mozlog == 3.2 01:19:21 INFO - moznetwork == 0.27 01:19:21 INFO - mozprocess == 0.22 01:19:21 INFO - mozprofile == 0.28 01:19:21 INFO - mozrunner == 6.11 01:19:21 INFO - mozscreenshot == 0.1 01:19:21 INFO - mozsystemmonitor == 0.3 01:19:21 INFO - moztest == 0.7 01:19:21 INFO - mozversion == 1.4 01:19:21 INFO - psutil == 3.1.1 01:19:21 INFO - requests == 1.2.3 01:19:21 INFO - wsgiref == 0.1.2 01:19:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:21 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 0x7f41f94d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2075450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21042c0>, '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 0x21051c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2105650>, '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': 'd2a8c569965ab8367867b893000001a1-1467101506.332576-40929488', '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 01:19:21 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 01:19:21 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 01:19:21 INFO - Using env: {'DISPLAY': ':0', 01:19:21 INFO - 'HOME': '/home/cltbld', 01:19:21 INFO - 'LANG': 'en_US.UTF-8', 01:19:21 INFO - 'LANGUAGE': 'en_US:en', 01:19:21 INFO - 'LOGNAME': 'cltbld', 01:19:21 INFO - 'MAIL': '/var/mail/cltbld', 01:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:21 INFO - 'MOZ_NO_REMOTE': '1', 01:19:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:21 INFO - 'NO_EM_RESTART': '1', 01:19:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:21 INFO - 'PWD': '/builds/slave/test', 01:19:21 INFO - 'SHELL': '/bin/bash', 01:19:21 INFO - 'SHLVL': '1', 01:19:21 INFO - 'TERM': 'linux', 01:19:21 INFO - 'TMOUT': '86400', 01:19:21 INFO - 'USER': 'cltbld', 01:19:21 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467101506.332576-40929488', 01:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:21 INFO - '_': '/tools/buildbot/bin/python'} 01:19:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:21 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)) 01:19:21 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)) 01:19:21 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)) 01:19:21 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)) 01:19:21 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)) 01:19:21 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)) 01:19:21 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)) 01:19:21 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)) 01:19:21 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)) 01:19:21 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)) 01:19:21 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)) 01:19:21 INFO - Cleaning up... 01:19:21 INFO - Return code: 0 01:19:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f41f94d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2075450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21042c0>, '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 0x21051c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2105650>, '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': 'd2a8c569965ab8367867b893000001a1-1467101506.332576-40929488', '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 01:19:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:19:21 INFO - Using env: {'DISPLAY': ':0', 01:19:21 INFO - 'HOME': '/home/cltbld', 01:19:21 INFO - 'LANG': 'en_US.UTF-8', 01:19:21 INFO - 'LANGUAGE': 'en_US:en', 01:19:21 INFO - 'LOGNAME': 'cltbld', 01:19:21 INFO - 'MAIL': '/var/mail/cltbld', 01:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:21 INFO - 'MOZ_NO_REMOTE': '1', 01:19:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:21 INFO - 'NO_EM_RESTART': '1', 01:19:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:21 INFO - 'PWD': '/builds/slave/test', 01:19:21 INFO - 'SHELL': '/bin/bash', 01:19:21 INFO - 'SHLVL': '1', 01:19:21 INFO - 'TERM': 'linux', 01:19:21 INFO - 'TMOUT': '86400', 01:19:21 INFO - 'USER': 'cltbld', 01:19:21 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467101506.332576-40929488', 01:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:21 INFO - '_': '/tools/buildbot/bin/python'} 01:19:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:19:21 INFO - Cleaning up... 01:19:21 INFO - Return code: 0 01:19:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f41f94d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2075450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21042c0>, '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 0x21051c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2105650>, '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': 'd2a8c569965ab8367867b893000001a1-1467101506.332576-40929488', '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 01:19:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:19:21 INFO - Using env: {'DISPLAY': ':0', 01:19:21 INFO - 'HOME': '/home/cltbld', 01:19:21 INFO - 'LANG': 'en_US.UTF-8', 01:19:21 INFO - 'LANGUAGE': 'en_US:en', 01:19:21 INFO - 'LOGNAME': 'cltbld', 01:19:21 INFO - 'MAIL': '/var/mail/cltbld', 01:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:21 INFO - 'MOZ_NO_REMOTE': '1', 01:19:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:21 INFO - 'NO_EM_RESTART': '1', 01:19:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:21 INFO - 'PWD': '/builds/slave/test', 01:19:21 INFO - 'SHELL': '/bin/bash', 01:19:21 INFO - 'SHLVL': '1', 01:19:21 INFO - 'TERM': 'linux', 01:19:21 INFO - 'TMOUT': '86400', 01:19:21 INFO - 'USER': 'cltbld', 01:19:21 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467101506.332576-40929488', 01:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:21 INFO - '_': '/tools/buildbot/bin/python'} 01:19:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:21 INFO - Downloading/unpacking flake8 01:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:19:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:19:23 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 01:19:23 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 01:19:23 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 01:19:23 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 01:19:23 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 01:19:23 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 01:19:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:19:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:19:23 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 01:19:23 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 01:19:23 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 01:19:23 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 01:19:23 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 01:19:23 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 01:19:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:19: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 01:19: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 01:19: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 01:19: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 01:19: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 01:19: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 01:19:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:19:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:19:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:19:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:19:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:19:24 INFO - no previously-included directories found matching 'docs/_build' 01:19:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:19:24 INFO - Running setup.py install for pep8 01:19:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:19:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:19:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:19:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:19:25 INFO - no previously-included directories found matching 'docs/_build' 01:19:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:19:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:19:25 INFO - Cleaning up... 01:19:25 INFO - Return code: 0 01:19:25 INFO - Running post-action listener: _resource_record_post_action 01:19:25 INFO - Running post-action listener: _start_resource_monitoring 01:19:25 INFO - Starting resource monitoring. 01:19:25 INFO - ##### 01:19:25 INFO - ##### Finished create-virtualenv step (success) 01:19:25 INFO - ##### 01:19:25 INFO - ##### 01:19:25 INFO - ##### Running install step. 01:19:25 INFO - ##### 01:19:25 INFO - Running pre-action listener: _resource_record_pre_action 01:19:25 INFO - Running main action method: install 01:19:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:19:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:19:26 INFO - Reading from file tmpfile_stdout 01:19:26 INFO - Detecting whether we're running mozinstall >=1.0... 01:19:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:19:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:19:26 INFO - Reading from file tmpfile_stdout 01:19:26 INFO - Output received: 01:19:26 INFO - Usage: mozinstall [options] installer 01:19:26 INFO - Options: 01:19:26 INFO - -h, --help show this help message and exit 01:19:26 INFO - -d DEST, --destination=DEST 01:19:26 INFO - Directory to install application into. [default: 01:19:26 INFO - "/builds/slave/test"] 01:19:26 INFO - --app=APP Application being installed. [default: firefox] 01:19:26 INFO - mkdir: /builds/slave/test/build/application 01:19:26 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'] 01:19:26 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 01:19:41 INFO - Reading from file tmpfile_stdout 01:19:41 INFO - Output received: 01:19:41 INFO - /builds/slave/test/build/application/firefox/firefox 01:19:41 INFO - Running post-action listener: _resource_record_post_action 01:19:41 INFO - ##### 01:19:41 INFO - ##### Finished install step (success) 01:19:41 INFO - ##### 01:19:41 INFO - ##### 01:19:41 INFO - ##### Running run-tests step. 01:19:41 INFO - ##### 01:19:41 INFO - Running pre-action listener: _resource_record_pre_action 01:19:41 INFO - Running main action method: run_tests 01:19:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:19:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:19:41 INFO - Python 2.7.3 01:19:41 INFO - Return code: 0 01:19:41 INFO - grabbing minidump binary from tooltool 01:19:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:41 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 0x21042c0>, '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 0x21051c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2105650>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:19:41 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 01:19:41 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 01:19:41 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 01:19:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:19:42 INFO - Return code: 0 01:19:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:19:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:19:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:19:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:19:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:19:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:19:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:19:42 INFO - Return code: 0 01:19:42 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/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 01:19:42 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/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 01:19:42 INFO - Using env: {'DISPLAY': ':0', 01:19:42 INFO - 'HOME': '/home/cltbld', 01:19:42 INFO - 'LANG': 'en_US.UTF-8', 01:19:42 INFO - 'LANGUAGE': 'en_US:en', 01:19:42 INFO - 'LOGNAME': 'cltbld', 01:19:42 INFO - 'MAIL': '/var/mail/cltbld', 01:19:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:19:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:42 INFO - 'MOZ_NO_REMOTE': '1', 01:19:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:19:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:42 INFO - 'NO_EM_RESTART': '1', 01:19:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:42 INFO - 'PWD': '/builds/slave/test', 01:19:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:19:42 INFO - 'SHELL': '/bin/bash', 01:19:42 INFO - 'SHLVL': '1', 01:19:42 INFO - 'TERM': 'linux', 01:19:42 INFO - 'TMOUT': '86400', 01:19:42 INFO - 'USER': 'cltbld', 01:19:42 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467101506.332576-40929488', 01:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:42 INFO - '_': '/tools/buildbot/bin/python'} 01:19:42 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/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 01:19:43 INFO - mozversion application_buildid: 20160627130921 01:19:43 INFO - mozversion application_changeset: f20f82876561686c4f8a619a0e1baa9f58261e0f 01:19:43 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:19:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:19:43 INFO - mozversion application_name: Firefox 01:19:43 INFO - mozversion application_remotingname: firefox-dev 01:19:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:19:43 INFO - mozversion application_vendor: Mozilla 01:19:43 INFO - mozversion application_version: 49.0a2 01:19:43 INFO - mozversion platform_buildid: 20160627130921 01:19:43 INFO - mozversion platform_changeset: f20f82876561686c4f8a619a0e1baa9f58261e0f 01:19:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:19:43 INFO - mozversion platform_version: 49.0a2 01:19:43 INFO - using testdate: 1467101983 01:19:43 INFO - actual date: 1467101983 01:19:43 INFO - starting webserver on 'localhost:57307' 01:19:43 INFO - SUITE-START | Running 2 tests 01:19:43 INFO - TEST-START | dromaeo_css 01:19:43 INFO - operating with platform_type : linux_ 01:19:43 INFO - Initialising browser for dromaeo_css test... 01:19:43 INFO - TEST-INFO | started process 672 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp8SAm_/profile http://localhost:57307/getInfo.html) 01:19:47 INFO - PROCESS | 672 | __metrics Screen width/height:1600/1200 01:19:47 INFO - PROCESS | 672 | colorDepth:24 01:19:47 INFO - PROCESS | 672 | Browser inner width/height: 1024/697 01:19:47 INFO - PROCESS | 672 | __metrics 01:19:48 ERROR - PROCESS | 672 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:19:49 INFO - TEST-INFO | 672: exit 0 01:19:49 INFO - Browser initialized. 01:19:49 INFO - Running cycle 1/1 for dromaeo_css test... 01:19:49 INFO - TEST-INFO | started process 768 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp8SAm_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:20:01 INFO - PROCESS | 768 | RSS: Main: 145182720 01:20:01 INFO - PROCESS | 768 | 01:20:52 INFO - PROCESS | 768 | 1467102052351 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] 01:23:00 INFO - PROCESS | 768 | Cycle 1(1): loaded http://localhost:57307/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57307/tests/dromaeo/cssquery-ext.html) 01:23:01 INFO - PROCESS | 768 | RSS: Main: 255987712 01:23:01 INFO - PROCESS | 768 | 01:26:04 INFO - PROCESS | 768 | Cycle 1(1): loaded http://localhost:57307/tests/dromaeo/cssquery-ext.html (next: http://localhost:57307/tests/dromaeo/cssquery-jquery.html) 01:26:04 INFO - PROCESS | 768 | RSS: Main: 227692544 01:26:04 INFO - PROCESS | 768 | 01:29:06 INFO - PROCESS | 768 | Cycle 1(1): loaded http://localhost:57307/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57307/tests/dromaeo/cssquery-mootools.html) 01:29:07 INFO - PROCESS | 768 | RSS: Main: 240582656 01:29:07 INFO - PROCESS | 768 | 01:32:09 INFO - PROCESS | 768 | Cycle 1(1): loaded http://localhost:57307/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57307/tests/dromaeo/cssquery-prototype.html) 01:32:09 INFO - PROCESS | 768 | RSS: Main: 226709504 01:32:09 INFO - PROCESS | 768 | 01:35:12 INFO - PROCESS | 768 | Cycle 1(1): loaded http://localhost:57307/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57307/tests/dromaeo/cssquery-yui.html) 01:35:13 INFO - PROCESS | 768 | RSS: Main: 216776704 01:35:13 INFO - PROCESS | 768 | 01:38:15 INFO - PROCESS | 768 | Cycle 1(1): loaded http://localhost:57307/tests/dromaeo/cssquery-yui.html (next: http://localhost:57307/tests/dromaeo/cssquery-dojo.html) 01:38:15 INFO - PROCESS | 768 | RSS: Main: 258412544 01:38:15 INFO - PROCESS | 768 | 01:38:15 INFO - PROCESS | 768 | __start_tp_report 01:38:15 INFO - PROCESS | 768 | _x_x_mozilla_page_load 01:38:15 INFO - PROCESS | 768 | _x_x_mozilla_page_load_details 01:38:15 INFO - PROCESS | 768 | |i|pagename|runs| 01:38:15 INFO - PROCESS | 768 | |0;dojo.html;3222.452183128868;3394.643562425945;3395.9320813583736;3397.1337308986203;3400.8129552874584;5651.519620832229;5672.546196304296;5718.971405142968;5730.169125476803;5739.397363276858;5630.5495560355175;5667.829965101043;5669.348024977118;5675.971620141904;5690.089585666284;4952.801887924478;5016.498350164972;5096.261042148886;5099.133147364957;5142.588592912577;5139.049275883955;5185.792568297264;5187.844364669066;5192.169252919533;5192.532672059514;5020.121478741224;5055.924161137567;5078.847634570969;5085.771140298695;5111.591072714193;5154.07226699194;5174.896502069975;5179.741012949337;5184.507471790174;5202.661826981234;4930.087933732235;5015.598752099823;5051.090803655341;5084.339035925343;5099.872503187413;5519.834404967857;5524.281843360378;5540.501354878081;5543.223948647193;5589.524890384322;6093.450137719143;6107.297660769024;6108;6110.541709371815;6114.082887566856;6038.63768173911;6052.848678783022;6080.574359794816;6104.725287362079;6157.507399408037;5695.259616249861;5717.342505611825;5734.856628584277;5751.396103409165;5753.741081651336;6021.729022194012;6239.251289845248;6247.562670613104;6254.906176407358;6257.186565746515;5874;5961.940380596226;5967.522598192134;5993.730282137314;6006.969965150146;6069.605475644069;6080.232766695221;6080.270367555921;6097.817065488042;6115.449609535074;5887.087501437284;5999.370066142992;6046.5767396281835;6050.515958723292;6061.333253342129;6050.636961782219;6111.113888486145;6117.279373342205;6119.015143218386;6139.386061393825;4626;4626.21354369758;4629.722216667011;4631.328457373662;4653;4065.5527891931865;4066.9186616267507;4086.6730661547003;4128.236276288896;4143.15065411596;5772.393898640582;5774;5783.103618939072;5788.3343415506915;5793.507551858139;6059.27288725347;6107.606420791524;6113.541484388688;6114.847128821815;6135.07973803933;5632.549396048306;5673.546116310686;5714.142878568165;5756.971215143897;5784.50831679312;5173.611979101583;5185.377754669388;5185.585153187736;5195.19474481456;5207.270982062439;6222.657753823492;6230.56386052981;6243.406876346739;6250.093736408196;6255.0617407388345;5899.970500147472;6070.878582428239;6073.726682299395;6100.725467354068;6120.938790612036;6281.403266689657;6283.622982621057;6322.0516922462;6326.6520341381665;6332.588381755171;6022.969885150546;6027.638341699512;6041.24484439445;6043;6043.12374705674;5948.970255148696;5977.6114552553945;6001.489873360639;6017.06735456005;6031.487323577545;5899.764009439746;5907.143464197753;5907.911381329198;5912.793052243151;5915.349311575809;5786.3056433228285;5817.447342502455;5847.970760146172;5866.6480011199465;5873.2658417697785;5785.363610002981;5816.127580862904;5835.649861008353;5874.706264686663;5883.617564858442;5955.076963070731;6034.39656034393;6044.909326360196;6048.12302216185;6050.364711705208;5668.659880407189;5800.9419905800405;5826.592138550261;5834.03738383162;5835.241418615723 01:38:15 INFO - PROCESS | 768 | |1;ext.html;592.650336301582;635.8632893927805;644.4844124700242;650.6941737383431;671.1141293492585;34611;37855.24289514212;37999;38035;38039.23921521568;48202;49153;49203.50796492034;51693;51933;9137.90862091379;9264.44413335202;9276.860847087299;9279.443233406017;9284.210842078432;8565.571721413935;9144.862827057566;10728.302660327094;11103.83344249837;11105.389203593799;11256.155788315868;11300.830487542693;11347;11347.602833900815;11351.03516201124;8494.957525212396;11014.614488492904;11075;11078.667639970814;11085.113190944705;10699.251052426333;11132.721681958015;11140.944295278552;11147.275427097213;11458.541658333657;42975.206611570145;43448.78275608602;46260.53739462596;46350.76824615889;46467.76766116148;3674.706023518112;3789.4694742736037;3790.469334293201;3847.557530883956;3974.880753577397;34501.30997380038;35141.29717405663;35149;35158;35235.823820880985;4678.8596342109795;4714.245720684674;4746.430428348585;4752.738599377068;4851.151048566522;427520;429620;430603;430659.84670076764;431277;73363.2663673367;73412;73459;73772.26227737761;73893;41912.790436047624;42830.785846071194;42868.35697464541;44621.55378446239;76128;20100.095495702728;20227.797722022886;20357.592848142955;20365.08357123933;20375.18499260013;14025.298735063207;15271.236438178046;15466.304016319293;15471.922640386727;15476.613084672974;22051.558968820533;22891.656625150637;22947.196848110238;23077.423064423525;23092.884535577214;8032.3172530334405;8182.7545173644885;8213.835723285501;8370.455920365157;8433.578321083922;1097.434821067151;1108.8115020446544;1171.6485054483621;1187.8871507206802;1199.1186477938709;34731.30537389289;35244;35783.28433431317;35806.104847378505;35835.64164358323;1187.8337032815414;1194.7252132009687;1204.765070811201;1246.5138595947587;1299.818025476434;18199.363022294157;18501.704300194808;18589.34937277189;18606.348777792984;18695.813041869405;600034;608599;608689;609319;609496;65803.67098164478;66138.33861661321;66375.66812165908;66381.33618663752;66390.66804665946;1402.4390243902521;1446.2840893757448;1463.9926800366143;1474.1891959422276;1534.3862455017859;32851.67148328486;35954.8202258987;36089.27821443609;36606.267874642894;36738.26523469569;56663.43336566581;56997;57022.7148864253;57050.714746426005;57108.42891571031;439712;440242;440461;442692;443423;31703.52444713285;31823.204419889687;32251.838740807085;32623;33772.15569610681;54725;56230.71884640551;56390.71804640951;57379;57379.42620573741;46020;46644.7667761659;46674.53325466702;46873.53126468828;48231.75884120557;45029;46020.30969535393;46137;46458;47389.76305118452;46400.53599463962;46436;47529.28706069342;47862.76068619774;48830.26754598613;40373.59626403698;41539;41864.60332693509;41896.3715544261;42246.78876605597;30235.546466803455;30714.84642576773;30882;30895.227619308796;31256 01:38:15 INFO - PROCESS | 768 | |2;jquery.html;428.34463271195085;433.1488624852165;436.8361864300886;444.6642784697553;448.09484840621946;19313.130909109088;20274.695879561783;21019.2643257486;21060.262890798826;21159.894200528994;19907;21156.823986895233;21364.4658883528;21373.57252854942;21407.892960535213;5776.133579963008;6044.788432404866;6079.118527813464;6080.14877917092;6080.939190608082;5778.59549831512;5912.379200183962;5938.673372964486;6043.546733994968;6047.244094488189;5825.242718446596;5873.207117039209;5889.116632505137;5893.64638121712;5894.616849904743;5804.303483581976;5896.646201227919;5962.642241465483;5981.700914954235;5994.760209591611;5131.4098878629065;5296.549793267577;5344.866378340573;5348.545373643245;5399.433059528732;24486.87756561206;24518.754812451825;24649;24956.875215623804;25024.874875625686;2500.374906273432;2554.514642217973;2649.337665583604;2674.638923745289;2698.0421950207788;14479.3484293206;15115.773263401057;15129.394824207018;15235.162066086361;15763.369465221378;1994.8503862210391;2052.4560991337307;2139.689744986984;2254.3462395905167;2298.161171172527;91629;92808.53595731978;94990;95836.52081739616;96642.51678741562;11635.53457861693;11830.645080647595;11979.221350612357;12104.81842772359;12113.273203607812;17102.315907363816;17241.741373879402;17257;17312.307507699552;17316.567085822702;8977.775555611162;9013.549322533847;9055.094490551024;9198.540072996324;9220.44677319363;8802.823943521094;8833.381663283508;8854.778630534289;8941.418807777474;8953.283737301;5077.517635824591;5110.207917772751;5151.4333423323405;5157.123289040797;5253.868653283698;2037.7554693436587;2048.723422337995;2110.2825039486647;2126.9468263293234;2136.2629892686996;986.8717066781272;1017.2574020964589;1023.8771347438206;1041.037040737315;1119.8936101070385;19025.350480130222;19715.30996415147;20112.39662810118;20270.540481094136;20300.492487687927;1069.1610430060284;1081.8431327457474;1101.3446999035561;1115.6206889657556;1133.1048471707259;10772.730681733019;11240.437978101063;11261.268017578996;11354;11365.147613928822;427723;428289;431918;557452;571891;104827;110928;112171;113360.43319783348;117846.41076794732;1087.6845714742794;1121.400050972742;1122.6912599035168;1123.4607388453587;1143.279733767721;17126.40057597978;18413.171407286973;18473.815261847747;18889.244430223185;18933.715994260372;39512.60487395089;44132;44222.557774421846;44769;45562.77218614018;53308;63860;64839.351606485216;65103.67448162729;65965;9184.12750788674;9317.208037316905;9443.95278023633;9532.332736708364;9614.855777163208;10767.730806729895;14300.642483937985;14340.139591624536;14596.781048284496;14597.635059123606;12101.152919295564;12103.334316612318;12173.513059477522;12444;12848.678783030125;12299.323537205539;12442.37788110609;12566.937165314115;12792.936035319764;12855.485780569046;12105.33420661872;12766.553170638983;12802.67993300175;12879.806802897776;13132.277724725232;9274.397164184307;9435.24518038569;9447.385919915183;9481.051894810464;9492.762680933032;9296.907030929604;11724.648260552198;12048.75902481928;12124.454399551865;12388.81416778731 01:38:15 INFO - PROCESS | 768 | |3;mootools.html;1445.9132452052884;1570.1913514540013;1615.652634683543;1785.6160925401036;1907.8187572180648;8961.596728147233;9385.202257808094;9429.858552121716;9708.61165553377;9713.125818676317;9230.538473076353;9477.905220947789;9510.714678559654;9510.952445237781;9515.476648784314;2231.665250212465;2515.584928486807;2538.086288935986;2571.8585477798715;2591.598302263152;2552.221572420411;2570.8714564271804;2577.7937764978756;2579.471208402273;2581.2643396631966;2557.360659835041;2576;2578.187870820695;2578.278082136995;2580.780633646142;2174.771648976858;2474.6288056791445;2558.897644094234;2559.9104031358997;2578.046122934526;2531.5949448088218;2541.339251794528;2550.3624093976505;2575.7553032461888;2576.716561178269;9336.39313444624;9358.953205233931;9403.106704863027;9418.340716149873;9420.952895235549;5910.734016969247;6086.360932102154;6088.117223002684;6096.725647345836;6104.694765261719;3380.6450322716005;3473.2532505511185;3547.527775972968;3549.6450354964554;3552.0942159749097;1103.0568863621568;1114.6266000889711;1150.2408410449148;1150.4995327032684;1163.598558497317;14200.360983755756;14203.431862725478;14213.502527411594;14231.07498012626;14235.359408826627;5172.250023746536;5234.345706786652;5253.159494480865;5280.762365693553;5353.571714262927;11531.827022594667;11561.942190288995;11598.304101753922;11609.187356884937;11650.766984660258;5281.260623512711;5926.555508336892;5968.074948383008;6013.699315034319;6014.699265036731;4922.310876477296;4989.5758860496535;5094.796208151706;5451.890962180813;5463.754131064112;4452.844150454784;4488.483824360241;4502.8198872045405;4524.977375113103;4549.7042692224895;1374.1342953938954;1377.01543396472;1384.8615138486273;1419.7018626088432;1425.0808228692642;927.9628814847465;984.6209209454269;1007.5012868630075;1022.345698752784;1032.4012072997793;6440.323766004596;6493.448056915215;6548.1814773153355;6549.2468366137555;6568.978269995855;953.2802733935835;964.5177411294353;967.3663750243602;988.4464699768153;1021.4433133942019;4315.913681726348;4381.233284175257;4405.118976204772;4414.4702635683925;4422.601965823092;12415.068869834799;12861.549845755353;12921.418536165895;12957.352132393342;12964.481420743254;12016.09879259059;12405.62783116508;12413.627591172279;12795.360231988363;12802.551910683082;9124.224440922464;9227.16955474024;9319.627214911328;9329.906700932905;9333;6307.180066591313;6660.900086498609;6692.096566963398;6799.592024478349;6858.417034552119;11161.33032018049;11449.59926402572;11593.478293476983;11655.76688466243;11789.115816313983;11256.268342557707;11498.25261358009;11593.478293476644;11714.941425292818;12057.975072118968;7968;8615;8665.740027799176;8743.431676940978;8930.19628233462;8890.244329232088;9301.302402319989;9362.110599493037;9386.06139386056;9409;8198;8321.958390208252;8336.499810011419;8363;8395.454295470774;8156.062052863759;8182.7954301142945;8356.415050946618;8447.408681392244;8447.577621119042;7423.480356375002;7578.696852126074;7591.316781489692;7596.316331530189;7596.886046709415;5383.067912673814;5469.56243500511;5501.862453438696;5565.1374037024325;5707.885842283048;5648.2092507049865;5672.2058911751565;5693.3168019837885;5727.284089488814;5773.509251713652 01:38:15 INFO - PROCESS | 768 | |4;prototype.html;356.1719003317288;356.9179088809574;358.9066842620918;359.503884639198;361.15309598990376;5463.945360546399;5475.412130482156;5535.142052981784;5554.583406244533;5574.327701689497;5523.447655234475;5534.972325138378;5548.58385621079;5551.361593416758;5562.249096371988;3974.9006274843214;4047.7773722445254;4292.742435453867;4315.82736690532;4331.65346772259;4227.0489139943575;4267.295896177143;4283.3146696528565;4310.5042920064125;4311.3748506466545;4063.817128229222;4274.871753847389;4294.398784170218;4298.247806633843;4317;4120.423140760296;4282.443282373302;4283.421738065353;4294.184105020036;4329.805158767863;3782.7730336179916;3806.410006449005;3822.9617703822883;3830.108268257448;3839.712021598363;5234.26720259164;5300.939812037569;5329.028259543994;5338.759755810997;5340.584745042567;4973.850784476472;4995.500449955011;5033.874153146164;5034.4713805050305;5035.899282014376;5535.833924982257;5593.468620481048;5770.509506691937;5805.5065319447895;5863.149843272701;4158.875233742992;4247.7451352918615;4259.446271984653;4269.850555230552;4285.314349704064;5871.4128587141795;5994.6403215807195;6017.458428741435;6045.45590896817;6045.939540604626;4304.418903448057;4320.308750599889;4356.629686476685;4362.716423432466;4366.694331396771;4349.347597860283;4426.247537918562;4435.112977404532;4446.155230506193;4454.7549884756645;4971.5028497150715;4980.078685443204;4995.200767877195;4998.725070121178;5000.224965130411;5756.913646295309;5801.477866991907;5853.560982926298;5856.472917437366;5860.882782344329;1508.2911031815029;1515.613518552784;1525.9313330900136;1530.2884158866182;1542.8534289242505;954.5275088830934;994.3139233928566;997.3567049253191;1000.694788089625;1007.4032658236777;4970.304157417964;4988.476209997971;4990.600751939836;5039.924401133986;5074.492550744896;5243.397009343898;5290.68255904647;5306.230596563477;5330.360356757214;5346.705931173823;4832.371791667061;5011.195969450995;5036.722980236049;5046.4953504649975;5067;2801.0252771795836;2833.107571115092;2848.572714092861;2851.244420228641;2865.555838844982;5412.83761487156;5447.754851031713;5508.7521061552325;5533.446655334515;5564.803567233064;5452.854900470946;5711.3146422428745;6206.262246570877;6211.937880621136;6221.782237621662;6001.969990150022;6076;6249.625022498664;6273.529485288622;6279.811605651837;6059.424354686298;6063.818085457443;6075.392460753889;6096.390360963868;6105.786297479567;5644.842807224427;5873.295204575478;5928.480395831668;5945.137954996588;5978.641281523122;6177.598456100339;6180.6600636965395;6186.700792833555;6196.915539780431;6223.719932603134;4255.957440425556;4271.893202669959;4294.141171765722;4302.010537576438;4315.266404711144;5859.94140058594;5966.552508561788;5988.191594134911;6010.609310394811;6110.541709371903;5803.738831752666;5825.563082768725;5897.3807750185615;5898.852528686645;5901.7639294427745;5780.190773291826;5823.679697616672;5908.497777688945;5915.674637894957;5916.73374698131;5778.335491418373;5785.884282314246;5806.82579522615;5810.215620891126;5825.621334613236;5761.798337058183;5875.441833025856;5879.176915231786;5885.440883116097;5892.292924849045;5558.972205138948;5728.627639203439;5735.4551317624755;5751.9424805751405;5756.136579513107 01:38:15 INFO - PROCESS | 768 | |5;yui.html;817.5626040068561;835.6657337065175;836.6611522333455;844.7845799321176;913.4382354851759;15298.235088245585;15397.076175429467;15477;16698.916505417485;17128.657426851456;14611.415543378278;14772.630684232872;14778.261086945637;14852.702945941075;14866.108033517996;733.2850470790963;851.2083762101244;865.1521508921245;873.3100850328233;879.5734068976541;875.5622188905547;875.7591662292889;880.0143838900409;880.4541184465609;880.4761167105562;933.2347475070445;934.8971613122551;935.9110884465965;935.9532023398802;936.0265324062966;753.6947536247828;878.9121087891224;887.5118684723409;898.5192921786812;903.0292435631723;658.3285049249786;658.6081281637418;661.163628010567;664;664.5016237821634;15155.242237888171;15190.392384304614;15197.924010379877;15219.847801521953;15227.543173704807;14123.71752564943;14290.857091429056;14385.208813515252;14686.339114739756;14925.477608283767;13078.367594977084;13158;13169.670758231025;13185.274809885452;13407.932960335136;4620.930686039712;4645.651576131803;4705.5764981151515;4726.810927562893;4731.053789242131;77677;79953.60023199905;80105.59947200227;80469;80545;11480.94259528697;11586.76826463483;11593.362365070003;11853.407329633485;11862.940685296518;21530.46173845635;21557.67663485049;21576.136954521957;21836.45408864791;21845.890770546044;8407.369447291478;8463.195996380335;8514.632964991682;8814.823703525894;8846.380753347205;4953.925691114636;5010.799568017239;5029.8491045267965;5118;5120.897582048338;3538.1508437975217;3665.2119794244363;3671.889843304705;3672.265546890633;3674.0447483654443;602.728772052578;623.7785586116954;627.8367624417684;666.5833853841349;709.1454796969639;698.3470455124475;790.7983464216703;802.9076656184496;825.162460102996;837.8324335132997;10497.842532362021;10542.26204165701;10680.159074692272;10687.519061642244;10689.30519516229;685.6400389795298;760.8059944714063;800.3557136505053;801.1827935505752;835.9958200209081;4741.217699079613;4768.594669453136;4776.9761151194025;4814.903701926012;5093.343250278914;119701;127406;134326;136266.318668408;138818;109557.45221274003;109593;109699.45150274197;110403.44798276118;111443.44278278718;65430;65660.34339656637;80558.59720701359;95165.048349517;98655.50672246593;9321.207697345802;9556.331056825955;9586.66446674363;9613.951930240304;9639.228861691188;45753.77123114363;46308.30537542007;57170.14149292602;58686.70656646689;59389;73941;74963.62518187374;75130;75490.62254688691;75883.62058189894;13885.514007009706;14184.50354237638;14219.573412797632;14275.64310892236;14639.634009149431;14438.566842994727;14537.127772333693;15625.296861641025;16194.109323987293;16260.51218463448;12395.194312369667;12684;13105.14816536922;14419.927900360432;14615.196164211071;13375.799363009368;13633.727325453634;13911.930440347733;14680;14890;13843.307834608027;13954.372053257424;13963.860361396257;14370.3533341002;14502.637434064232;11545.826812597987;11936.343501107522;11985.760284794082;12105.69735756578;12172.208806427554;12048.698782530508;12438.626841194779;12468.501259949864;12568.183068100545;12765.808512872129 01:38:15 INFO - PROCESS | 768 | __end_tp_report 01:38:15 INFO - PROCESS | 768 | __start_cc_report 01:38:15 INFO - PROCESS | 768 | _x_x_mozilla_cycle_collect,890 01:38:15 INFO - PROCESS | 768 | __end_cc_report 01:38:15 INFO - PROCESS | 768 | __startTimestamp1467103095775__endTimestamp 01:38:15 INFO - PROCESS | 768 | 01:38:15 INFO - PROCESS | 768 | ------- Summary: start ------- 01:38:15 INFO - PROCESS | 768 | Number of tests: 6 01:38:15 INFO - PROCESS | 768 | 01:38:15 INFO - PROCESS | 768 | [#0] dojo.html Cycles:165 Average:5625.96 Median:5834.04 stddev:642.14 (11.0%) stddev-sans-first:615.81 01:38:15 INFO - PROCESS | 768 | Values: 3222.5 3394.6 3395.9 3397.1 3400.8 5651.5 5672.5 5719.0 5730.2 5739.4 5630.5 5667.8 5669.3 5676.0 5690.1 4952.8 5016.5 5096.3 5099.1 5142.6 5139.0 5185.8 5187.8 5192.2 5192.5 5020.1 5055.9 5078.8 5085.8 5111.6 5154.1 5174.9 5179.7 5184.5 5202.7 4930.1 5015.6 5051.1 5084.3 5099.9 5519.8 5524.3 5540.5 5543.2 5589.5 6093.5 6107.3 6108.0 6110.5 6114.1 6038.6 6052.8 6080.6 6104.7 6157.5 5695.3 5717.3 5734.9 5751.4 5753.7 6021.7 6239.3 6247.6 6254.9 6257.2 5874.0 5961.9 5967.5 5993.7 6007.0 6069.6 6080.2 6080.3 6097.8 6115.4 5887.1 5999.4 6046.6 6050.5 6061.3 6050.6 6111.1 6117.3 6119.0 6139.4 4626.0 4626.2 4629.7 4631.3 4653.0 4065.6 4066.9 4086.7 4128.2 4143.2 5772.4 5774.0 5783.1 5788.3 5793.5 6059.3 6107.6 6113.5 6114.8 6135.1 5632.5 5673.5 5714.1 5757.0 5784.5 5173.6 5185.4 5185.6 5195.2 5207.3 6222.7 6230.6 6243.4 6250.1 6255.1 5900.0 6070.9 6073.7 6100.7 6120.9 6281.4 6283.6 6322.1 6326.7 6332.6 6023.0 6027.6 6041.2 6043.0 6043.1 5949.0 5977.6 6001.5 6017.1 6031.5 5899.8 5907.1 5907.9 5912.8 5915.3 5786.3 5817.4 5848.0 5866.6 5873.3 5785.4 5816.1 5835.6 5874.7 5883.6 5955.1 6034.4 6044.9 6048.1 6050.4 5668.7 5800.9 5826.6 5834.0 5835.2 01:38:15 INFO - PROCESS | 768 | 01:38:15 INFO - PROCESS | 768 | [#1] ext.html Cycles:180 Average:67102.18 Median:41904.58 stddev:132371.03 (315.9%) stddev-sans-first:132648.18 01:38:15 INFO - PROCESS | 768 | Values: 592.7 635.9 644.5 650.7 671.1 34611.0 37855.2 37999.0 38035.0 38039.2 48202.0 49153.0 49203.5 51693.0 51933.0 9137.9 9264.4 9276.9 9279.4 9284.2 8565.6 9144.9 10728.3 11103.8 11105.4 11256.2 11300.8 11347.0 11347.6 11351.0 8495.0 11014.6 11075.0 11078.7 11085.1 10699.3 11132.7 11140.9 11147.3 11458.5 42975.2 43448.8 46260.5 46350.8 46467.8 3674.7 3789.5 3790.5 3847.6 3974.9 34501.3 35141.3 35149.0 35158.0 35235.8 4678.9 4714.2 4746.4 4752.7 4851.2 427520.0 429620.0 430603.0 430659.8 431277.0 73363.3 73412.0 73459.0 73772.3 73893.0 41912.8 42830.8 42868.4 44621.6 76128.0 20100.1 20227.8 20357.6 20365.1 20375.2 14025.3 15271.2 15466.3 15471.9 15476.6 22051.6 22891.7 22947.2 23077.4 23092.9 8032.3 8182.8 8213.8 8370.5 8433.6 1097.4 1108.8 1171.6 1187.9 1199.1 34731.3 35244.0 35783.3 35806.1 35835.6 1187.8 1194.7 1204.8 1246.5 1299.8 18199.4 18501.7 18589.3 18606.3 18695.8 600034.0 608599.0 608689.0 609319.0 609496.0 65803.7 66138.3 66375.7 66381.3 66390.7 1402.4 1446.3 1464.0 1474.2 1534.4 32851.7 35954.8 36089.3 36606.3 36738.3 56663.4 56997.0 57022.7 57050.7 57108.4 439712.0 440242.0 440461.0 442692.0 443423.0 31703.5 31823.2 32251.8 32623.0 33772.2 54725.0 56230.7 56390.7 57379.0 57379.4 46020.0 46644.8 46674.5 46873.5 48231.8 45029.0 46020.3 46137.0 46458.0 47389.8 46400.5 46436.0 47529.3 47862.8 48830.3 40373.6 41539.0 41864.6 41896.4 42246.8 30235.5 30714.8 30882.0 30895.2 31256.0 01:38:15 INFO - PROCESS | 768 | 01:38:15 INFO - PROCESS | 768 | [#2] jquery.html Cycles:180 Average:30569.62 Median:11831.12 stddev:81218.19 (686.5%) stddev-sans-first:81414.50 01:38:15 INFO - PROCESS | 768 | Values: 428.3 433.1 436.8 444.7 448.1 19313.1 20274.7 21019.3 21060.3 21159.9 19907.0 21156.8 21364.5 21373.6 21407.9 5776.1 6044.8 6079.1 6080.1 6080.9 5778.6 5912.4 5938.7 6043.5 6047.2 5825.2 5873.2 5889.1 5893.6 5894.6 5804.3 5896.6 5962.6 5981.7 5994.8 5131.4 5296.5 5344.9 5348.5 5399.4 24486.9 24518.8 24649.0 24956.9 25024.9 2500.4 2554.5 2649.3 2674.6 2698.0 14479.3 15115.8 15129.4 15235.2 15763.4 1994.9 2052.5 2139.7 2254.3 2298.2 91629.0 92808.5 94990.0 95836.5 96642.5 11635.5 11830.6 11979.2 12104.8 12113.3 17102.3 17241.7 17257.0 17312.3 17316.6 8977.8 9013.5 9055.1 9198.5 9220.4 8802.8 8833.4 8854.8 8941.4 8953.3 5077.5 5110.2 5151.4 5157.1 5253.9 2037.8 2048.7 2110.3 2126.9 2136.3 986.9 1017.3 1023.9 1041.0 1119.9 19025.4 19715.3 20112.4 20270.5 20300.5 1069.2 1081.8 1101.3 1115.6 1133.1 10772.7 11240.4 11261.3 11354.0 11365.1 427723.0 428289.0 431918.0 557452.0 571891.0 104827.0 110928.0 112171.0 113360.4 117846.4 1087.7 1121.4 1122.7 1123.5 1143.3 17126.4 18413.2 18473.8 18889.2 18933.7 39512.6 44132.0 44222.6 44769.0 45562.8 53308.0 63860.0 64839.4 65103.7 65965.0 9184.1 9317.2 9444.0 9532.3 9614.9 10767.7 14300.6 14340.1 14596.8 14597.6 12101.2 12103.3 12173.5 12444.0 12848.7 12299.3 12442.4 12566.9 12792.9 12855.5 12105.3 12766.6 12802.7 12879.8 13132.3 9274.4 9435.2 9447.4 9481.1 9492.8 9296.9 11724.6 12048.8 12124.5 12388.8 01:38:15 INFO - PROCESS | 768 | 01:38:15 INFO - PROCESS | 768 | [#3] mootools.html Cycles:180 Average:6440.15 Median:5042.19 stddev:3764.23 (74.7%) stddev-sans-first:3756.08 01:38:15 INFO - PROCESS | 768 | Values: 1445.9 1570.2 1615.7 1785.6 1907.8 8961.6 9385.2 9429.9 9708.6 9713.1 9230.5 9477.9 9510.7 9511.0 9515.5 2231.7 2515.6 2538.1 2571.9 2591.6 2552.2 2570.9 2577.8 2579.5 2581.3 2557.4 2576.0 2578.2 2578.3 2580.8 2174.8 2474.6 2558.9 2559.9 2578.0 2531.6 2541.3 2550.4 2575.8 2576.7 9336.4 9359.0 9403.1 9418.3 9421.0 5910.7 6086.4 6088.1 6096.7 6104.7 3380.6 3473.3 3547.5 3549.6 3552.1 1103.1 1114.6 1150.2 1150.5 1163.6 14200.4 14203.4 14213.5 14231.1 14235.4 5172.3 5234.3 5253.2 5280.8 5353.6 11531.8 11561.9 11598.3 11609.2 11650.8 5281.3 5926.6 5968.1 6013.7 6014.7 4922.3 4989.6 5094.8 5451.9 5463.8 4452.8 4488.5 4502.8 4525.0 4549.7 1374.1 1377.0 1384.9 1419.7 1425.1 928.0 984.6 1007.5 1022.3 1032.4 6440.3 6493.4 6548.2 6549.2 6569.0 953.3 964.5 967.4 988.4 1021.4 4315.9 4381.2 4405.1 4414.5 4422.6 12415.1 12861.5 12921.4 12957.4 12964.5 12016.1 12405.6 12413.6 12795.4 12802.6 9124.2 9227.2 9319.6 9329.9 9333.0 6307.2 6660.9 6692.1 6799.6 6858.4 11161.3 11449.6 11593.5 11655.8 11789.1 11256.3 11498.3 11593.5 11714.9 12058.0 7968.0 8615.0 8665.7 8743.4 8930.2 8890.2 9301.3 9362.1 9386.1 9409.0 8198.0 8322.0 8336.5 8363.0 8395.5 8156.1 8182.8 8356.4 8447.4 8447.6 7423.5 7578.7 7591.3 7596.3 7596.9 5383.1 5469.6 5501.9 5565.1 5707.9 5648.2 5672.2 5693.3 5727.3 5773.5 01:38:15 INFO - PROCESS | 768 | 01:38:15 INFO - PROCESS | 768 | [#4] prototype.html Cycles:180 Average:4830.66 Median:5343.65 stddev:1420.95 (26.6%) stddev-sans-first:1384.68 01:38:15 INFO - PROCESS | 768 | Values: 356.2 356.9 358.9 359.5 361.2 5463.9 5475.4 5535.1 5554.6 5574.3 5523.4 5535.0 5548.6 5551.4 5562.2 3974.9 4047.8 4292.7 4315.8 4331.7 4227.0 4267.3 4283.3 4310.5 4311.4 4063.8 4274.9 4294.4 4298.2 4317.0 4120.4 4282.4 4283.4 4294.2 4329.8 3782.8 3806.4 3823.0 3830.1 3839.7 5234.3 5300.9 5329.0 5338.8 5340.6 4973.9 4995.5 5033.9 5034.5 5035.9 5535.8 5593.5 5770.5 5805.5 5863.1 4158.9 4247.7 4259.4 4269.9 4285.3 5871.4 5994.6 6017.5 6045.5 6045.9 4304.4 4320.3 4356.6 4362.7 4366.7 4349.3 4426.2 4435.1 4446.2 4454.8 4971.5 4980.1 4995.2 4998.7 5000.2 5756.9 5801.5 5853.6 5856.5 5860.9 1508.3 1515.6 1525.9 1530.3 1542.9 954.5 994.3 997.4 1000.7 1007.4 4970.3 4988.5 4990.6 5039.9 5074.5 5243.4 5290.7 5306.2 5330.4 5346.7 4832.4 5011.2 5036.7 5046.5 5067.0 2801.0 2833.1 2848.6 2851.2 2865.6 5412.8 5447.8 5508.8 5533.4 5564.8 5452.9 5711.3 6206.3 6211.9 6221.8 6002.0 6076.0 6249.6 6273.5 6279.8 6059.4 6063.8 6075.4 6096.4 6105.8 5644.8 5873.3 5928.5 5945.1 5978.6 6177.6 6180.7 6186.7 6196.9 6223.7 4256.0 4271.9 4294.1 4302.0 4315.3 5859.9 5966.6 5988.2 6010.6 6110.5 5803.7 5825.6 5897.4 5898.9 5901.8 5780.2 5823.7 5908.5 5915.7 5916.7 5778.3 5785.9 5806.8 5810.2 5825.6 5761.8 5875.4 5879.2 5885.4 5892.3 5559.0 5728.6 5735.5 5751.9 5756.1 01:38:15 INFO - PROCESS | 768 | 01:38:15 INFO - PROCESS | 768 | [#5] yui.html Cycles:180 Average:21883.09 Median:25187.35 stddev:32249.26 (128.0%) stddev-sans-first:32300.94 01:38:15 INFO - PROCESS | 768 | Values: 817.6 835.7 836.7 844.8 913.4 15298.2 15397.1 15477.0 16698.9 17128.7 14611.4 14772.6 14778.3 14852.7 14866.1 733.3 851.2 865.2 873.3 879.6 875.6 875.8 880.0 880.5 880.5 933.2 934.9 935.9 936.0 936.0 753.7 878.9 887.5 898.5 903.0 658.3 658.6 661.2 664.0 664.5 15155.2 15190.4 15197.9 15219.8 15227.5 14123.7 14290.9 14385.2 14686.3 14925.5 13078.4 13158.0 13169.7 13185.3 13407.9 4620.9 4645.7 4705.6 4726.8 4731.1 77677.0 79953.6 80105.6 80469.0 80545.0 11480.9 11586.8 11593.4 11853.4 11862.9 21530.5 21557.7 21576.1 21836.5 21845.9 8407.4 8463.2 8514.6 8814.8 8846.4 4953.9 5010.8 5029.8 5118.0 5120.9 3538.2 3665.2 3671.9 3672.3 3674.0 602.7 623.8 627.8 666.6 709.1 698.3 790.8 802.9 825.2 837.8 10497.8 10542.3 10680.2 10687.5 10689.3 685.6 760.8 800.4 801.2 836.0 4741.2 4768.6 4777.0 4814.9 5093.3 119701.0 127406.0 134326.0 136266.3 138818.0 109557.5 109593.0 109699.5 110403.4 111443.4 65430.0 65660.3 80558.6 95165.0 98655.5 9321.2 9556.3 9586.7 9614.0 9639.2 45753.8 46308.3 57170.1 58686.7 59389.0 73941.0 74963.6 75130.0 75490.6 75883.6 13885.5 14184.5 14219.6 14275.6 14639.6 14438.6 14537.1 15625.3 16194.1 16260.5 12395.2 12684.0 13105.1 14419.9 14615.2 13375.8 13633.7 13911.9 14680.0 14890.0 13843.3 13954.4 13963.9 14370.4 14502.6 11545.8 11936.3 11985.8 12105.7 12172.2 12048.7 12438.6 12468.5 12568.2 12765.8 01:38:15 INFO - PROCESS | 768 | -------- Summary: end -------- 01:38:15 INFO - PROCESS | 768 | 01:38:16 INFO - TEST-INFO | 768: exit 0 01:38:16 INFO - TEST-OK | dromaeo_css | took 1113325ms 01:38:16 INFO - TEST-START | kraken 01:38:16 INFO - operating with platform_type : linux_ 01:38:16 INFO - Initialising browser for kraken test... 01:38:16 INFO - TEST-INFO | started process 963 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUr5je3/profile http://localhost:57307/getInfo.html) 01:38:20 INFO - PROCESS | 963 | __metrics Screen width/height:1600/1200 01:38:20 INFO - PROCESS | 963 | colorDepth:24 01:38:20 INFO - PROCESS | 963 | Browser inner width/height: 1024/697 01:38:20 INFO - PROCESS | 963 | __metrics 01:38:21 ERROR - PROCESS | 963 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:38:22 INFO - TEST-INFO | 963: exit 0 01:38:22 INFO - Browser initialized. 01:38:22 INFO - Running cycle 1/1 for kraken test... 01:38:22 INFO - TEST-INFO | started process 1062 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUr5je3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:38:34 INFO - PROCESS | 1062 | RSS: Main: 148819968 01:38:34 INFO - PROCESS | 1062 | 01:38:36 INFO - PROCESS | 1062 | Cycle 1(1): loaded http://localhost:57307/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57307/tests/kraken/driver.html?testName=audio-beat-detection) 01:38:37 INFO - PROCESS | 1062 | RSS: Main: 198639616 01:38:37 INFO - PROCESS | 1062 | 01:38:40 INFO - PROCESS | 1062 | Cycle 1(1): loaded http://localhost:57307/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57307/tests/kraken/driver.html?testName=audio-dft) 01:38:40 INFO - PROCESS | 1062 | RSS: Main: 196673536 01:38:40 INFO - PROCESS | 1062 | 01:38:43 INFO - PROCESS | 1062 | Cycle 1(1): loaded http://localhost:57307/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57307/tests/kraken/driver.html?testName=audio-fft) 01:38:44 INFO - PROCESS | 1062 | RSS: Main: 283299840 01:38:44 INFO - PROCESS | 1062 | 01:38:46 INFO - PROCESS | 1062 | Cycle 1(1): loaded http://localhost:57307/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57307/tests/kraken/driver.html?testName=audio-oscillator) 01:38:46 INFO - PROCESS | 1062 | RSS: Main: 191598592 01:38:46 INFO - PROCESS | 1062 | 01:38:49 INFO - PROCESS | 1062 | Cycle 1(1): loaded http://localhost:57307/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57307/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:38:49 INFO - PROCESS | 1062 | RSS: Main: 192733184 01:38:49 INFO - PROCESS | 1062 | 01:38:52 INFO - PROCESS | 1062 | Cycle 1(1): loaded http://localhost:57307/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57307/tests/kraken/driver.html?testName=imaging-darkroom) 01:38:53 INFO - PROCESS | 1062 | RSS: Main: 227270656 01:38:53 INFO - PROCESS | 1062 | 01:38:56 INFO - PROCESS | 1062 | Cycle 1(1): loaded http://localhost:57307/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57307/tests/kraken/driver.html?testName=imaging-desaturate) 01:38:57 INFO - PROCESS | 1062 | RSS: Main: 227807232 01:38:57 INFO - PROCESS | 1062 | 01:38:59 INFO - PROCESS | 1062 | Cycle 1(1): loaded http://localhost:57307/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57307/tests/kraken/driver.html?testName=json-parse-financial) 01:39:00 INFO - PROCESS | 1062 | RSS: Main: 227721216 01:39:00 INFO - PROCESS | 1062 | 01:39:02 INFO - PROCESS | 1062 | Cycle 1(1): loaded http://localhost:57307/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57307/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:39:02 INFO - PROCESS | 1062 | RSS: Main: 204673024 01:39:02 INFO - PROCESS | 1062 | 01:39:04 INFO - PROCESS | 1062 | Cycle 1(1): loaded http://localhost:57307/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57307/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:39:04 INFO - PROCESS | 1062 | RSS: Main: 206094336 01:39:04 INFO - PROCESS | 1062 | 01:39:06 INFO - PROCESS | 1062 | Cycle 1(1): loaded http://localhost:57307/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57307/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:39:07 INFO - PROCESS | 1062 | RSS: Main: 211587072 01:39:07 INFO - PROCESS | 1062 | 01:39:10 INFO - PROCESS | 1062 | Cycle 1(1): loaded http://localhost:57307/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57307/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:39:10 INFO - PROCESS | 1062 | RSS: Main: 215752704 01:39:10 INFO - PROCESS | 1062 | 01:39:13 INFO - PROCESS | 1062 | Cycle 1(1): loaded http://localhost:57307/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57307/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:39:13 INFO - PROCESS | 1062 | RSS: Main: 213331968 01:39:13 INFO - PROCESS | 1062 | 01:39:15 INFO - PROCESS | 1062 | Cycle 1(1): loaded http://localhost:57307/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57307/tests/kraken/driver.html?testName=ai-astar) 01:39:15 INFO - PROCESS | 1062 | RSS: Main: 256774144 01:39:15 INFO - PROCESS | 1062 | 01:39:15 INFO - PROCESS | 1062 | __start_tp_report 01:39:15 INFO - PROCESS | 1062 | _x_x_mozilla_page_load 01:39:15 INFO - PROCESS | 1062 | _x_x_mozilla_page_load_details 01:39:15 INFO - PROCESS | 1062 | |i|pagename|runs| 01:39:15 INFO - PROCESS | 1062 | |0;ai-astar;110;106;109;109;110;108;109;110;110;109 01:39:15 INFO - PROCESS | 1062 | |1;audio-beat-detection;153;122;124;179;124;124;151;129;159;122 01:39:15 INFO - PROCESS | 1062 | |2;audio-dft;160;162;163;160;161;162;161;160;160;162 01:39:15 INFO - PROCESS | 1062 | |3;audio-fft;74;74;75;120;75;75;76;76;102;76 01:39:15 INFO - PROCESS | 1062 | |4;audio-oscillator;83;95;113;84;85;84;114;84;85;130 01:39:15 INFO - PROCESS | 1062 | |5;imaging-gaussian-blur;116;117;116;116;117;116;118;118;117;117 01:39:15 INFO - PROCESS | 1062 | |6;imaging-darkroom;145;146;146;146;145;146;146;146;145;145 01:39:15 INFO - PROCESS | 1062 | |7;imaging-desaturate;95;95;96;95;96;96;95;95;94;95 01:39:15 INFO - PROCESS | 1062 | |8;json-parse-financial;49;48;49;50;51;51;52;51;51;52 01:39:15 INFO - PROCESS | 1062 | |9;json-stringify-tinderbox;59;60;60;60;61;59;59;59;59;61 01:39:15 INFO - PROCESS | 1062 | |10;stanford-crypto-aes;80;76;76;76;77;77;77;77;129;77 01:39:15 INFO - PROCESS | 1062 | |11;stanford-crypto-ccm;126;123;118;125;125;117;116;116;121;118 01:39:15 INFO - PROCESS | 1062 | |12;stanford-crypto-pbkdf2;153;156;157;154;155;152;156;153;155;152 01:39:15 INFO - PROCESS | 1062 | |13;stanford-crypto-sha256-iterative;61;62;64;61;61;61;61;61;61;64 01:39:15 INFO - PROCESS | 1062 | __end_tp_report 01:39:15 INFO - PROCESS | 1062 | __start_cc_report 01:39:15 INFO - PROCESS | 1062 | _x_x_mozilla_cycle_collect,1579 01:39:15 INFO - PROCESS | 1062 | __end_cc_report 01:39:15 INFO - PROCESS | 1062 | __startTimestamp1467103155760__endTimestamp 01:39:15 INFO - PROCESS | 1062 | 01:39:15 INFO - PROCESS | 1062 | ------- Summary: start ------- 01:39:15 INFO - PROCESS | 1062 | Number of tests: 14 01:39:15 INFO - PROCESS | 1062 | 01:39:15 INFO - PROCESS | 1062 | [#0] ai-astar Cycles:10 Average:109.00 Median:109.50 stddev:1.25 (1.1%) stddev-sans-first:1.27 01:39:15 INFO - PROCESS | 1062 | Values: 110.0 106.0 109.0 109.0 110.0 108.0 109.0 110.0 110.0 109.0 01:39:15 INFO - PROCESS | 1062 | 01:39:15 INFO - PROCESS | 1062 | [#1] audio-beat-detection Cycles:10 Average:138.70 Median:140.00 stddev:20.25 (14.5%) stddev-sans-first:20.81 01:39:15 INFO - PROCESS | 1062 | Values: 153.0 122.0 124.0 179.0 124.0 124.0 151.0 129.0 159.0 122.0 01:39:15 INFO - PROCESS | 1062 | 01:39:15 INFO - PROCESS | 1062 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:1.10 (0.7%) stddev-sans-first:1.09 01:39:15 INFO - PROCESS | 1062 | Values: 160.0 162.0 163.0 160.0 161.0 162.0 161.0 160.0 160.0 162.0 01:39:15 INFO - PROCESS | 1062 | 01:39:15 INFO - PROCESS | 1062 | [#3] audio-fft Cycles:10 Average:82.30 Median:75.00 stddev:15.73 (21.0%) stddev-sans-first:16.39 01:39:15 INFO - PROCESS | 1062 | Values: 74.0 74.0 75.0 120.0 75.0 75.0 76.0 76.0 102.0 76.0 01:39:15 INFO - PROCESS | 1062 | 01:39:15 INFO - PROCESS | 1062 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:84.00 stddev:17.04 (20.3%) stddev-sans-first:17.44 01:39:15 INFO - PROCESS | 1062 | Values: 83.0 95.0 113.0 84.0 85.0 84.0 114.0 84.0 85.0 130.0 01:39:15 INFO - PROCESS | 1062 | 01:39:15 INFO - PROCESS | 1062 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 01:39:15 INFO - PROCESS | 1062 | Values: 116.0 117.0 116.0 116.0 117.0 116.0 118.0 118.0 117.0 117.0 01:39:15 INFO - PROCESS | 1062 | 01:39:15 INFO - PROCESS | 1062 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 01:39:15 INFO - PROCESS | 1062 | Values: 145.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 145.0 01:39:15 INFO - PROCESS | 1062 | 01:39:15 INFO - PROCESS | 1062 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 01:39:15 INFO - PROCESS | 1062 | Values: 95.0 95.0 96.0 95.0 96.0 96.0 95.0 95.0 94.0 95.0 01:39:15 INFO - PROCESS | 1062 | 01:39:15 INFO - PROCESS | 1062 | [#8] json-parse-financial Cycles:10 Average:50.40 Median:51.00 stddev:1.35 (2.6%) stddev-sans-first:1.33 01:39:15 INFO - PROCESS | 1062 | Values: 49.0 48.0 49.0 50.0 51.0 51.0 52.0 51.0 51.0 52.0 01:39:15 INFO - PROCESS | 1062 | 01:39:15 INFO - PROCESS | 1062 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.00 stddev:0.82 (1.4%) stddev-sans-first:0.83 01:39:15 INFO - PROCESS | 1062 | Values: 59.0 60.0 60.0 60.0 61.0 59.0 59.0 59.0 59.0 61.0 01:39:15 INFO - PROCESS | 1062 | 01:39:15 INFO - PROCESS | 1062 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:77.00 stddev:16.48 (21.4%) stddev-sans-first:17.47 01:39:15 INFO - PROCESS | 1062 | Values: 80.0 76.0 76.0 76.0 77.0 77.0 77.0 77.0 129.0 77.0 01:39:15 INFO - PROCESS | 1062 | 01:39:15 INFO - PROCESS | 1062 | [#11] stanford-crypto-ccm Cycles:10 Average:120.50 Median:122.00 stddev:3.98 (3.3%) stddev-sans-first:3.69 01:39:15 INFO - PROCESS | 1062 | Values: 126.0 123.0 118.0 125.0 125.0 117.0 116.0 116.0 121.0 118.0 01:39:15 INFO - PROCESS | 1062 | 01:39:15 INFO - PROCESS | 1062 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.30 Median:155.00 stddev:1.77 (1.1%) stddev-sans-first:1.81 01:39:15 INFO - PROCESS | 1062 | Values: 153.0 156.0 157.0 154.0 155.0 152.0 156.0 153.0 155.0 152.0 01:39:15 INFO - PROCESS | 1062 | 01:39:15 INFO - PROCESS | 1062 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.70 Median:61.00 stddev:1.25 (2.1%) stddev-sans-first:1.30 01:39:15 INFO - PROCESS | 1062 | Values: 61.0 62.0 64.0 61.0 61.0 61.0 61.0 61.0 61.0 64.0 01:39:15 INFO - PROCESS | 1062 | -------- Summary: end -------- 01:39:15 INFO - PROCESS | 1062 | 01:39:16 INFO - TEST-INFO | 1062: exit 0 01:39:16 INFO - TEST-OK | kraken | took 60227ms 01:39:16 INFO - SUITE-END | took 1173s 01:39:16 INFO - Completed test suite (00:19:33) 01:39:16 INFO - javascript benchmark 01:39:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3222.452183128868, 3394.643562425945, 3395.9320813583736, 3397.1337308986203, 3400.8129552874584, 5651.519620832229, 5672.546196304296, 5718.971405142968, 5730.169125476803, 5739.397363276858, 5630.5495560355175, 5667.829965101043, 5669.348024977118, 5675.971620141904, 5690.089585666284, 4952.801887924478, 5016.498350164972, 5096.261042148886, 5099.133147364957, 5142.588592912577, 5139.049275883955, 5185.792568297264, 5187.844364669066, 5192.169252919533, 5192.532672059514, 5020.121478741224, 5055.924161137567, 5078.847634570969, 5085.771140298695, 5111.591072714193, 5154.07226699194, 5174.896502069975, 5179.741012949337, 5184.507471790174, 5202.661826981234, 4930.087933732235, 5015.598752099823, 5051.090803655341, 5084.339035925343, 5099.872503187413, 5519.834404967857, 5524.281843360378, 5540.501354878081, 5543.223948647193, 5589.524890384322, 6093.450137719143, 6107.297660769024, 6108.0, 6110.541709371815, 6114.082887566856, 6038.63768173911, 6052.848678783022, 6080.574359794816, 6104.725287362079, 6157.507399408037, 5695.259616249861, 5717.342505611825, 5734.856628584277, 5751.396103409165, 5753.741081651336, 6021.729022194012, 6239.251289845248, 6247.562670613104, 6254.906176407358, 6257.186565746515, 5874.0, 5961.940380596226, 5967.522598192134, 5993.730282137314, 6006.969965150146, 6069.605475644069, 6080.232766695221, 6080.270367555921, 6097.817065488042, 6115.449609535074, 5887.087501437284, 5999.370066142992, 6046.5767396281835, 6050.515958723292, 6061.333253342129, 6050.636961782219, 6111.113888486145, 6117.279373342205, 6119.015143218386, 6139.386061393825, 4626.0, 4626.21354369758, 4629.722216667011, 4631.328457373662, 4653.0, 4065.5527891931865, 4066.9186616267507, 4086.6730661547003, 4128.236276288896, 4143.15065411596, 5772.393898640582, 5774.0, 5783.103618939072, 5788.3343415506915, 5793.507551858139, 6059.27288725347, 6107.606420791524, 6113.541484388688, 6114.847128821815, 6135.07973803933, 5632.549396048306, 5673.546116310686, 5714.142878568165, 5756.971215143897, 5784.50831679312, 5173.611979101583, 5185.377754669388, 5185.585153187736, 5195.19474481456, 5207.270982062439, 6222.657753823492, 6230.56386052981, 6243.406876346739, 6250.093736408196, 6255.0617407388345, 5899.970500147472, 6070.878582428239, 6073.726682299395, 6100.725467354068, 6120.938790612036, 6281.403266689657, 6283.622982621057, 6322.0516922462, 6326.6520341381665, 6332.588381755171, 6022.969885150546, 6027.638341699512, 6041.24484439445, 6043.0, 6043.12374705674, 5948.970255148696, 5977.6114552553945, 6001.489873360639, 6017.06735456005, 6031.487323577545, 5899.764009439746, 5907.143464197753, 5907.911381329198, 5912.793052243151, 5915.349311575809, 5786.3056433228285, 5817.447342502455, 5847.970760146172, 5866.6480011199465, 5873.2658417697785, 5785.363610002981, 5816.127580862904, 5835.649861008353, 5874.706264686663, 5883.617564858442, 5955.076963070731, 6034.39656034393, 6044.909326360196, 6048.12302216185, 6050.364711705208, 5668.659880407189, 5800.9419905800405, 5826.592138550261, 5834.03738383162, 5835.241418615723], "value": 5582.9241425273185, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.650336301582, 635.8632893927805, 644.4844124700242, 650.6941737383431, 671.1141293492585, 34611.0, 37855.24289514212, 37999.0, 38035.0, 38039.23921521568, 48202.0, 49153.0, 49203.50796492034, 51693.0, 51933.0, 9137.90862091379, 9264.44413335202, 9276.860847087299, 9279.443233406017, 9284.210842078432, 8565.571721413935, 9144.862827057566, 10728.302660327094, 11103.83344249837, 11105.389203593799, 11256.155788315868, 11300.830487542693, 11347.0, 11347.602833900815, 11351.03516201124, 8494.957525212396, 11014.614488492904, 11075.0, 11078.667639970814, 11085.113190944705, 10699.251052426333, 11132.721681958015, 11140.944295278552, 11147.275427097213, 11458.541658333657, 42975.206611570145, 43448.78275608602, 46260.53739462596, 46350.76824615889, 46467.76766116148, 3674.706023518112, 3789.4694742736037, 3790.469334293201, 3847.557530883956, 3974.880753577397, 34501.30997380038, 35141.29717405663, 35149.0, 35158.0, 35235.823820880985, 4678.8596342109795, 4714.245720684674, 4746.430428348585, 4752.738599377068, 4851.151048566522, 427520.0, 429620.0, 430603.0, 430659.84670076764, 431277.0, 73363.2663673367, 73412.0, 73459.0, 73772.26227737761, 73893.0, 41912.790436047624, 42830.785846071194, 42868.35697464541, 44621.55378446239, 76128.0, 20100.095495702728, 20227.797722022886, 20357.592848142955, 20365.08357123933, 20375.18499260013, 14025.298735063207, 15271.236438178046, 15466.304016319293, 15471.922640386727, 15476.613084672974, 22051.558968820533, 22891.656625150637, 22947.196848110238, 23077.423064423525, 23092.884535577214, 8032.3172530334405, 8182.7545173644885, 8213.835723285501, 8370.455920365157, 8433.578321083922, 1097.434821067151, 1108.8115020446544, 1171.6485054483621, 1187.8871507206802, 1199.1186477938709, 34731.30537389289, 35244.0, 35783.28433431317, 35806.104847378505, 35835.64164358323, 1187.8337032815414, 1194.7252132009687, 1204.765070811201, 1246.5138595947587, 1299.818025476434, 18199.363022294157, 18501.704300194808, 18589.34937277189, 18606.348777792984, 18695.813041869405, 600034.0, 608599.0, 608689.0, 609319.0, 609496.0, 65803.67098164478, 66138.33861661321, 66375.66812165908, 66381.33618663752, 66390.66804665946, 1402.4390243902521, 1446.2840893757448, 1463.9926800366143, 1474.1891959422276, 1534.3862455017859, 32851.67148328486, 35954.8202258987, 36089.27821443609, 36606.267874642894, 36738.26523469569, 56663.43336566581, 56997.0, 57022.7148864253, 57050.714746426005, 57108.42891571031, 439712.0, 440242.0, 440461.0, 442692.0, 443423.0, 31703.52444713285, 31823.204419889687, 32251.838740807085, 32623.0, 33772.15569610681, 54725.0, 56230.71884640551, 56390.71804640951, 57379.0, 57379.42620573741, 46020.0, 46644.7667761659, 46674.53325466702, 46873.53126468828, 48231.75884120557, 45029.0, 46020.30969535393, 46137.0, 46458.0, 47389.76305118452, 46400.53599463962, 46436.0, 47529.28706069342, 47862.76068619774, 48830.26754598613, 40373.59626403698, 41539.0, 41864.60332693509, 41896.3715544261, 42246.78876605597, 30235.546466803455, 30714.84642576773, 30882.0, 30895.227619308796, 31256.0], "value": 22473.279165453205, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.34463271195085, 433.1488624852165, 436.8361864300886, 444.6642784697553, 448.09484840621946, 19313.130909109088, 20274.695879561783, 21019.2643257486, 21060.262890798826, 21159.894200528994, 19907.0, 21156.823986895233, 21364.4658883528, 21373.57252854942, 21407.892960535213, 5776.133579963008, 6044.788432404866, 6079.118527813464, 6080.14877917092, 6080.939190608082, 5778.59549831512, 5912.379200183962, 5938.673372964486, 6043.546733994968, 6047.244094488189, 5825.242718446596, 5873.207117039209, 5889.116632505137, 5893.64638121712, 5894.616849904743, 5804.303483581976, 5896.646201227919, 5962.642241465483, 5981.700914954235, 5994.760209591611, 5131.4098878629065, 5296.549793267577, 5344.866378340573, 5348.545373643245, 5399.433059528732, 24486.87756561206, 24518.754812451825, 24649.0, 24956.875215623804, 25024.874875625686, 2500.374906273432, 2554.514642217973, 2649.337665583604, 2674.638923745289, 2698.0421950207788, 14479.3484293206, 15115.773263401057, 15129.394824207018, 15235.162066086361, 15763.369465221378, 1994.8503862210391, 2052.4560991337307, 2139.689744986984, 2254.3462395905167, 2298.161171172527, 91629.0, 92808.53595731978, 94990.0, 95836.52081739616, 96642.51678741562, 11635.53457861693, 11830.645080647595, 11979.221350612357, 12104.81842772359, 12113.273203607812, 17102.315907363816, 17241.741373879402, 17257.0, 17312.307507699552, 17316.567085822702, 8977.775555611162, 9013.549322533847, 9055.094490551024, 9198.540072996324, 9220.44677319363, 8802.823943521094, 8833.381663283508, 8854.778630534289, 8941.418807777474, 8953.283737301, 5077.517635824591, 5110.207917772751, 5151.4333423323405, 5157.123289040797, 5253.868653283698, 2037.7554693436587, 2048.723422337995, 2110.2825039486647, 2126.9468263293234, 2136.2629892686996, 986.8717066781272, 1017.2574020964589, 1023.8771347438206, 1041.037040737315, 1119.8936101070385, 19025.350480130222, 19715.30996415147, 20112.39662810118, 20270.540481094136, 20300.492487687927, 1069.1610430060284, 1081.8431327457474, 1101.3446999035561, 1115.6206889657556, 1133.1048471707259, 10772.730681733019, 11240.437978101063, 11261.268017578996, 11354.0, 11365.147613928822, 427723.0, 428289.0, 431918.0, 557452.0, 571891.0, 104827.0, 110928.0, 112171.0, 113360.43319783348, 117846.41076794732, 1087.6845714742794, 1121.400050972742, 1122.6912599035168, 1123.4607388453587, 1143.279733767721, 17126.40057597978, 18413.171407286973, 18473.815261847747, 18889.244430223185, 18933.715994260372, 39512.60487395089, 44132.0, 44222.557774421846, 44769.0, 45562.77218614018, 53308.0, 63860.0, 64839.351606485216, 65103.67448162729, 65965.0, 9184.12750788674, 9317.208037316905, 9443.95278023633, 9532.332736708364, 9614.855777163208, 10767.730806729895, 14300.642483937985, 14340.139591624536, 14596.781048284496, 14597.635059123606, 12101.152919295564, 12103.334316612318, 12173.513059477522, 12444.0, 12848.678783030125, 12299.323537205539, 12442.37788110609, 12566.937165314115, 12792.936035319764, 12855.485780569046, 12105.33420661872, 12766.553170638983, 12802.67993300175, 12879.806802897776, 13132.277724725232, 9274.397164184307, 9435.24518038569, 9447.385919915183, 9481.051894810464, 9492.762680933032, 9296.907030929604, 11724.648260552198, 12048.75902481928, 12124.454399551865, 12388.81416778731], "value": 9988.288585512017, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1445.9132452052884, 1570.1913514540013, 1615.652634683543, 1785.6160925401036, 1907.8187572180648, 8961.596728147233, 9385.202257808094, 9429.858552121716, 9708.61165553377, 9713.125818676317, 9230.538473076353, 9477.905220947789, 9510.714678559654, 9510.952445237781, 9515.476648784314, 2231.665250212465, 2515.584928486807, 2538.086288935986, 2571.8585477798715, 2591.598302263152, 2552.221572420411, 2570.8714564271804, 2577.7937764978756, 2579.471208402273, 2581.2643396631966, 2557.360659835041, 2576.0, 2578.187870820695, 2578.278082136995, 2580.780633646142, 2174.771648976858, 2474.6288056791445, 2558.897644094234, 2559.9104031358997, 2578.046122934526, 2531.5949448088218, 2541.339251794528, 2550.3624093976505, 2575.7553032461888, 2576.716561178269, 9336.39313444624, 9358.953205233931, 9403.106704863027, 9418.340716149873, 9420.952895235549, 5910.734016969247, 6086.360932102154, 6088.117223002684, 6096.725647345836, 6104.694765261719, 3380.6450322716005, 3473.2532505511185, 3547.527775972968, 3549.6450354964554, 3552.0942159749097, 1103.0568863621568, 1114.6266000889711, 1150.2408410449148, 1150.4995327032684, 1163.598558497317, 14200.360983755756, 14203.431862725478, 14213.502527411594, 14231.07498012626, 14235.359408826627, 5172.250023746536, 5234.345706786652, 5253.159494480865, 5280.762365693553, 5353.571714262927, 11531.827022594667, 11561.942190288995, 11598.304101753922, 11609.187356884937, 11650.766984660258, 5281.260623512711, 5926.555508336892, 5968.074948383008, 6013.699315034319, 6014.699265036731, 4922.310876477296, 4989.5758860496535, 5094.796208151706, 5451.890962180813, 5463.754131064112, 4452.844150454784, 4488.483824360241, 4502.8198872045405, 4524.977375113103, 4549.7042692224895, 1374.1342953938954, 1377.01543396472, 1384.8615138486273, 1419.7018626088432, 1425.0808228692642, 927.9628814847465, 984.6209209454269, 1007.5012868630075, 1022.345698752784, 1032.4012072997793, 6440.323766004596, 6493.448056915215, 6548.1814773153355, 6549.2468366137555, 6568.978269995855, 953.2802733935835, 964.5177411294353, 967.3663750243602, 988.4464699768153, 1021.4433133942019, 4315.913681726348, 4381.233284175257, 4405.118976204772, 4414.4702635683925, 4422.601965823092, 12415.068869834799, 12861.549845755353, 12921.418536165895, 12957.352132393342, 12964.481420743254, 12016.09879259059, 12405.62783116508, 12413.627591172279, 12795.360231988363, 12802.551910683082, 9124.224440922464, 9227.16955474024, 9319.627214911328, 9329.906700932905, 9333.0, 6307.180066591313, 6660.900086498609, 6692.096566963398, 6799.592024478349, 6858.417034552119, 11161.33032018049, 11449.59926402572, 11593.478293476983, 11655.76688466243, 11789.115816313983, 11256.268342557707, 11498.25261358009, 11593.478293476644, 11714.941425292818, 12057.975072118968, 7968.0, 8615.0, 8665.740027799176, 8743.431676940978, 8930.19628233462, 8890.244329232088, 9301.302402319989, 9362.110599493037, 9386.06139386056, 9409.0, 8198.0, 8321.958390208252, 8336.499810011419, 8363.0, 8395.454295470774, 8156.062052863759, 8182.7954301142945, 8356.415050946618, 8447.408681392244, 8447.577621119042, 7423.480356375002, 7578.696852126074, 7591.316781489692, 7596.316331530189, 7596.886046709415, 5383.067912673814, 5469.56243500511, 5501.862453438696, 5565.1374037024325, 5707.885842283048, 5648.2092507049865, 5672.2058911751565, 5693.3168019837885, 5727.284089488814, 5773.509251713652], "value": 5091.799628901232, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.1719003317288, 356.9179088809574, 358.9066842620918, 359.503884639198, 361.15309598990376, 5463.945360546399, 5475.412130482156, 5535.142052981784, 5554.583406244533, 5574.327701689497, 5523.447655234475, 5534.972325138378, 5548.58385621079, 5551.361593416758, 5562.249096371988, 3974.9006274843214, 4047.7773722445254, 4292.742435453867, 4315.82736690532, 4331.65346772259, 4227.0489139943575, 4267.295896177143, 4283.3146696528565, 4310.5042920064125, 4311.3748506466545, 4063.817128229222, 4274.871753847389, 4294.398784170218, 4298.247806633843, 4317.0, 4120.423140760296, 4282.443282373302, 4283.421738065353, 4294.184105020036, 4329.805158767863, 3782.7730336179916, 3806.410006449005, 3822.9617703822883, 3830.108268257448, 3839.712021598363, 5234.26720259164, 5300.939812037569, 5329.028259543994, 5338.759755810997, 5340.584745042567, 4973.850784476472, 4995.500449955011, 5033.874153146164, 5034.4713805050305, 5035.899282014376, 5535.833924982257, 5593.468620481048, 5770.509506691937, 5805.5065319447895, 5863.149843272701, 4158.875233742992, 4247.7451352918615, 4259.446271984653, 4269.850555230552, 4285.314349704064, 5871.4128587141795, 5994.6403215807195, 6017.458428741435, 6045.45590896817, 6045.939540604626, 4304.418903448057, 4320.308750599889, 4356.629686476685, 4362.716423432466, 4366.694331396771, 4349.347597860283, 4426.247537918562, 4435.112977404532, 4446.155230506193, 4454.7549884756645, 4971.5028497150715, 4980.078685443204, 4995.200767877195, 4998.725070121178, 5000.224965130411, 5756.913646295309, 5801.477866991907, 5853.560982926298, 5856.472917437366, 5860.882782344329, 1508.2911031815029, 1515.613518552784, 1525.9313330900136, 1530.2884158866182, 1542.8534289242505, 954.5275088830934, 994.3139233928566, 997.3567049253191, 1000.694788089625, 1007.4032658236777, 4970.304157417964, 4988.476209997971, 4990.600751939836, 5039.924401133986, 5074.492550744896, 5243.397009343898, 5290.68255904647, 5306.230596563477, 5330.360356757214, 5346.705931173823, 4832.371791667061, 5011.195969450995, 5036.722980236049, 5046.4953504649975, 5067.0, 2801.0252771795836, 2833.107571115092, 2848.572714092861, 2851.244420228641, 2865.555838844982, 5412.83761487156, 5447.754851031713, 5508.7521061552325, 5533.446655334515, 5564.803567233064, 5452.854900470946, 5711.3146422428745, 6206.262246570877, 6211.937880621136, 6221.782237621662, 6001.969990150022, 6076.0, 6249.625022498664, 6273.529485288622, 6279.811605651837, 6059.424354686298, 6063.818085457443, 6075.392460753889, 6096.390360963868, 6105.786297479567, 5644.842807224427, 5873.295204575478, 5928.480395831668, 5945.137954996588, 5978.641281523122, 6177.598456100339, 6180.6600636965395, 6186.700792833555, 6196.915539780431, 6223.719932603134, 4255.957440425556, 4271.893202669959, 4294.141171765722, 4302.010537576438, 4315.266404711144, 5859.94140058594, 5966.552508561788, 5988.191594134911, 6010.609310394811, 6110.541709371903, 5803.738831752666, 5825.563082768725, 5897.3807750185615, 5898.852528686645, 5901.7639294427745, 5780.190773291826, 5823.679697616672, 5908.497777688945, 5915.674637894957, 5916.73374698131, 5778.335491418373, 5785.884282314246, 5806.82579522615, 5810.215620891126, 5825.621334613236, 5761.798337058183, 5875.441833025856, 5879.176915231786, 5885.440883116097, 5892.292924849045, 5558.972205138948, 5728.627639203439, 5735.4551317624755, 5751.9424805751405, 5756.136579513107], "value": 4384.808905176672, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [817.5626040068561, 835.6657337065175, 836.6611522333455, 844.7845799321176, 913.4382354851759, 15298.235088245585, 15397.076175429467, 15477.0, 16698.916505417485, 17128.657426851456, 14611.415543378278, 14772.630684232872, 14778.261086945637, 14852.702945941075, 14866.108033517996, 733.2850470790963, 851.2083762101244, 865.1521508921245, 873.3100850328233, 879.5734068976541, 875.5622188905547, 875.7591662292889, 880.0143838900409, 880.4541184465609, 880.4761167105562, 933.2347475070445, 934.8971613122551, 935.9110884465965, 935.9532023398802, 936.0265324062966, 753.6947536247828, 878.9121087891224, 887.5118684723409, 898.5192921786812, 903.0292435631723, 658.3285049249786, 658.6081281637418, 661.163628010567, 664.0, 664.5016237821634, 15155.242237888171, 15190.392384304614, 15197.924010379877, 15219.847801521953, 15227.543173704807, 14123.71752564943, 14290.857091429056, 14385.208813515252, 14686.339114739756, 14925.477608283767, 13078.367594977084, 13158.0, 13169.670758231025, 13185.274809885452, 13407.932960335136, 4620.930686039712, 4645.651576131803, 4705.5764981151515, 4726.810927562893, 4731.053789242131, 77677.0, 79953.60023199905, 80105.59947200227, 80469.0, 80545.0, 11480.94259528697, 11586.76826463483, 11593.362365070003, 11853.407329633485, 11862.940685296518, 21530.46173845635, 21557.67663485049, 21576.136954521957, 21836.45408864791, 21845.890770546044, 8407.369447291478, 8463.195996380335, 8514.632964991682, 8814.823703525894, 8846.380753347205, 4953.925691114636, 5010.799568017239, 5029.8491045267965, 5118.0, 5120.897582048338, 3538.1508437975217, 3665.2119794244363, 3671.889843304705, 3672.265546890633, 3674.0447483654443, 602.728772052578, 623.7785586116954, 627.8367624417684, 666.5833853841349, 709.1454796969639, 698.3470455124475, 790.7983464216703, 802.9076656184496, 825.162460102996, 837.8324335132997, 10497.842532362021, 10542.26204165701, 10680.159074692272, 10687.519061642244, 10689.30519516229, 685.6400389795298, 760.8059944714063, 800.3557136505053, 801.1827935505752, 835.9958200209081, 4741.217699079613, 4768.594669453136, 4776.9761151194025, 4814.903701926012, 5093.343250278914, 119701.0, 127406.0, 134326.0, 136266.318668408, 138818.0, 109557.45221274003, 109593.0, 109699.45150274197, 110403.44798276118, 111443.44278278718, 65430.0, 65660.34339656637, 80558.59720701359, 95165.048349517, 98655.50672246593, 9321.207697345802, 9556.331056825955, 9586.66446674363, 9613.951930240304, 9639.228861691188, 45753.77123114363, 46308.30537542007, 57170.14149292602, 58686.70656646689, 59389.0, 73941.0, 74963.62518187374, 75130.0, 75490.62254688691, 75883.62058189894, 13885.514007009706, 14184.50354237638, 14219.573412797632, 14275.64310892236, 14639.634009149431, 14438.566842994727, 14537.127772333693, 15625.296861641025, 16194.109323987293, 16260.51218463448, 12395.194312369667, 12684.0, 13105.14816536922, 14419.927900360432, 14615.196164211071, 13375.799363009368, 13633.727325453634, 13911.930440347733, 14680.0, 14890.0, 13843.307834608027, 13954.372053257424, 13963.860361396257, 14370.3533341002, 14502.637434064232, 11545.826812597987, 11936.343501107522, 11985.760284794082, 12105.69735756578, 12172.208806427554, 12048.698782530508, 12438.626841194779, 12468.501259949864, 12568.183068100545, 12765.808512872129], "value": 7966.448719177618, "unit": "score"}], "name": "dromaeo_css", "value": 7786.79005858387, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 106.0, 109.0, 109.0, 110.0, 108.0, 109.0, 110.0, 110.0, 109.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 122.0, 124.0, 179.0, 124.0, 124.0, 151.0, 129.0, 159.0, 122.0], "value": 138.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 163.0, 160.0, 161.0, 162.0, 161.0, 160.0, 160.0, 162.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 120.0, 75.0, 75.0, 76.0, 76.0, 102.0, 76.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 95.0, 113.0, 84.0, 85.0, 84.0, 114.0, 84.0, 85.0, 130.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 117.0, 116.0, 118.0, 118.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 94.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 48.0, 49.0, 50.0, 51.0, 51.0, 52.0, 51.0, 51.0, 52.0], "value": 50.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 60.0, 61.0, 59.0, 59.0, 59.0, 59.0, 61.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 76.0, 76.0, 76.0, 77.0, 77.0, 77.0, 77.0, 129.0, 77.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 123.0, 118.0, 125.0, 125.0, 117.0, 116.0, 116.0, 121.0, 118.0], "value": 120.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 156.0, 157.0, 154.0, 155.0, 152.0, 156.0, 153.0, 155.0, 152.0], "value": 154.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 64.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 64.0], "value": 61.7, "unit": "score"}], "name": "kraken", "value": 1473.2, "alertThreshold": 2.0}]} 01:39:16 INFO - Return code: 0 01:39:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:39:17 ERROR - # TBPL SUCCESS # 01:39:17 INFO - Running post-action listener: _resource_record_post_action 01:39:17 INFO - ##### 01:39:17 INFO - ##### Finished run-tests step (success) 01:39:17 INFO - ##### 01:39:17 INFO - Running post-run listener: _resource_record_post_run 01:39:17 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 266240; Write bytes: 266051584; Read time: 160; Write time: 125036 01:39:17 INFO - TinderboxPrint: CPU usage
13.1% 01:39:17 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 160 01:39:17 INFO - TinderboxPrint: I/O write bytes / time
266,051,584 / 125,036 01:39:17 INFO - TinderboxPrint: CPU idle
8,260.4 (86.9%) 01:39:17 INFO - TinderboxPrint: CPU user
1,199.8 (12.6%) 01:39:17 INFO - TinderboxPrint: Swap in / out
0 / 0 01:39:17 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 13762560; Read time: 0; Write time: 892 01:39:17 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 266240; Write bytes: 252284928; Read time: 160; Write time: 123284 01:39:17 INFO - Running post-run listener: _upload_blobber_files 01:39:17 INFO - Blob upload gear active. 01:39:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:39:17 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 01:39:17 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'] 01:39:17 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 01:39:18 INFO - (blobuploader) - INFO - Open directory for files ... 01:39:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:39:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:39:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:39:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:39:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:39:21 INFO - (blobuploader) - INFO - Done attempting. 01:39:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:39:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:39:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:39:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:39:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:39:22 INFO - (blobuploader) - INFO - Done attempting. 01:39:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:39:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:39:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:39:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:39:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:39:23 INFO - (blobuploader) - INFO - Done attempting. 01:39:23 INFO - (blobuploader) - INFO - Iteration through files over. 01:39:23 INFO - Return code: 0 01:39:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:39:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:39:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03e8eccd063d5abaa758e3d4ac39e661992f65ea6a42a4d6f53ce1fe39efd8422f0a599a4cb95ad94feb16fce1992532f207147205c1a48762c57acee78af03a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5322b32a95ade3b877baa7b9c7c76fb7460729fa3f33eda771d24eed4876052bf596dd06bb5e3e9bbd554bef0fef386e4e91f8762eef46d14dd1f7c059700e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4aa966820cdddda467babb6512c541c827d311f493086ebdac72c36857dc536fc31ed9dd52f71241b8901ed932b272113e44dddccd295a5073440ea0dd310eb4"} 01:39:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:39:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:39:23 INFO - Contents: 01:39:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03e8eccd063d5abaa758e3d4ac39e661992f65ea6a42a4d6f53ce1fe39efd8422f0a599a4cb95ad94feb16fce1992532f207147205c1a48762c57acee78af03a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5322b32a95ade3b877baa7b9c7c76fb7460729fa3f33eda771d24eed4876052bf596dd06bb5e3e9bbd554bef0fef386e4e91f8762eef46d14dd1f7c059700e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4aa966820cdddda467babb6512c541c827d311f493086ebdac72c36857dc536fc31ed9dd52f71241b8901ed932b272113e44dddccd295a5073440ea0dd310eb4"} 01:39:23 INFO - Running post-run listener: copy_logs_to_upload_dir 01:39:23 INFO - Copying logs to upload dir... 01:39:23 INFO - mkdir: /builds/slave/test/build/upload/logs 01:39:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.395031 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-28 01:39:22.841433) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 01:39:22.846027) ========= 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=d2a8c569965ab8367867b893000001a1-1467101506.332576-40929488 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/03e8eccd063d5abaa758e3d4ac39e661992f65ea6a42a4d6f53ce1fe39efd8422f0a599a4cb95ad94feb16fce1992532f207147205c1a48762c57acee78af03a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5322b32a95ade3b877baa7b9c7c76fb7460729fa3f33eda771d24eed4876052bf596dd06bb5e3e9bbd554bef0fef386e4e91f8762eef46d14dd1f7c059700e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4aa966820cdddda467babb6512c541c827d311f493086ebdac72c36857dc536fc31ed9dd52f71241b8901ed932b272113e44dddccd295a5073440ea0dd310eb4"} build_url:https://queue.taskcluster.net/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011124 build_url: 'https://queue.taskcluster.net/v1/task/KccG4N1aShm063uDnaMcSw/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/03e8eccd063d5abaa758e3d4ac39e661992f65ea6a42a4d6f53ce1fe39efd8422f0a599a4cb95ad94feb16fce1992532f207147205c1a48762c57acee78af03a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5322b32a95ade3b877baa7b9c7c76fb7460729fa3f33eda771d24eed4876052bf596dd06bb5e3e9bbd554bef0fef386e4e91f8762eef46d14dd1f7c059700e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4aa966820cdddda467babb6512c541c827d311f493086ebdac72c36857dc536fc31ed9dd52f71241b8901ed932b272113e44dddccd295a5073440ea0dd310eb4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 01:39:22.874060) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:39:22.874469) ========= 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=d2a8c569965ab8367867b893000001a1-1467101506.332576-40929488 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004413 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 01:39:22.924289) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 01:39:22.924874) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 01:39:22.925168) ========= ========= Total master_lag: 0.95 =========