builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-057 starttime: 1467113500.12 results: success (0) buildid: 20160628015111 builduid: e696099f82a842cd89f1f09181473898 revision: fb650a44de9ebb79104dd29b9534827398bf40de ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 04:31:40.116726) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 04:31:40.119950) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 04:31:40.120287) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 04:31:40.135609) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 04:31:40.135974) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1467113499.862650-567041491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-28 04:31:40-- 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% 46.6M=0s 2016-06-28 04:31:40 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085420 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 04:31:40.236156) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 04:31:40.236477) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1467113499.862650-567041491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018845 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 04:31:40.287076) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 04:31:40.287431) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev fb650a44de9ebb79104dd29b9534827398bf40de --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 fb650a44de9ebb79104dd29b9534827398bf40de --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=934fc3100db09dcb9af4d4b6000001ab-1467113499.862650-567041491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-28 04:31:40,885 truncating revision to first 12 chars 2016-06-28 04:31:40,886 Setting DEBUG logging. 2016-06-28 04:31:40,886 attempt 1/10 2016-06-28 04:31:40,886 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/fb650a44de9e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 04:31:41,188 unpacking tar archive at: mozilla-aurora-fb650a44de9e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.643057 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 04:31:40.944310) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 04:31:40.944648) ========= script_repo_revision: fb650a44de9ebb79104dd29b9534827398bf40de ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 04:31:40.945092) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 04:31:40.945373) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 04:31:40.956588) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-28 04:31:40.956967) ========= /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=934fc3100db09dcb9af4d4b6000001ab-1467113499.862650-567041491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:31:41 INFO - MultiFileLogger online at 20160628 04:31:41 in /builds/slave/test 04:31: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 04:31:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:31:41 INFO - {'append_to_log': False, 04:31:41 INFO - 'base_work_dir': '/builds/slave/test', 04:31:41 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:31:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:31:41 INFO - 'branch': 'Mozilla-Aurora', 04:31:41 INFO - 'buildbot_json_path': 'buildprops.json', 04:31:41 INFO - 'config_files': ('talos/linux_config.py',), 04:31:41 INFO - 'default_actions': ('clobber', 04:31:41 INFO - 'read-buildbot-config', 04:31:41 INFO - 'download-and-extract', 04:31:41 INFO - 'populate-webroot', 04:31:41 INFO - 'create-virtualenv', 04:31:41 INFO - 'install', 04:31:41 INFO - 'run-tests'), 04:31:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:31:41 INFO - 'download_minidump_stackwalk': True, 04:31:41 INFO - 'download_symbols': 'ondemand', 04:31:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:31:41 INFO - 'tooltool.py': '/tools/tooltool.py', 04:31:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:31:41 INFO - '/tools/misc-python/virtualenv.py')}, 04:31:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:31:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:31:41 INFO - 'installer_path': 'installer.exe', 04:31:41 INFO - 'log_level': 'info', 04:31:41 INFO - 'log_name': 'talos', 04:31:41 INFO - 'log_to_console': True, 04:31:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:31:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:31:41 INFO - 'opt_config_files': (), 04:31:41 INFO - 'pip_index': False, 04:31:41 INFO - 'sps_profile': False, 04:31:41 INFO - 'sps_profile_interval': 0, 04:31:41 INFO - 'suite': 'dromaeojs', 04:31:41 INFO - 'system_bits': '32', 04:31:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:31:41 INFO - 'title': 'talos-linux64-ix-057', 04:31:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:31:41 INFO - 'use_talos_json': True, 04:31:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:31:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:31:41 INFO - 'work_dir': 'build'} 04:31:41 INFO - ##### 04:31:41 INFO - ##### Running clobber step. 04:31:41 INFO - ##### 04:31:41 INFO - Running pre-action listener: _resource_record_pre_action 04:31:41 INFO - Running main action method: clobber 04:31:41 INFO - rmtree: /builds/slave/test/build 04:31:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:31:42 INFO - Running post-action listener: _resource_record_post_action 04:31:42 INFO - ##### 04:31:42 INFO - ##### Finished clobber step (success) 04:31:42 INFO - ##### 04:31:42 INFO - ##### 04:31:42 INFO - ##### Running read-buildbot-config step. 04:31:42 INFO - ##### 04:31:42 INFO - Running pre-action listener: _resource_record_pre_action 04:31:42 INFO - Running main action method: read_buildbot_config 04:31:42 INFO - Using buildbot properties: 04:31:42 INFO - { 04:31:42 INFO - "project": "", 04:31:42 INFO - "product": "firefox", 04:31:42 INFO - "script_repo_revision": "production", 04:31:42 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 04:31:42 INFO - "repository": "", 04:31:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 04:31:42 INFO - "buildid": "20160628015111", 04:31:42 INFO - "pgo_build": "True", 04:31:42 INFO - "basedir": "/builds/slave/test", 04:31:42 INFO - "buildnumber": 583, 04:31:42 INFO - "slavename": "talos-linux64-ix-057", 04:31:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:31:42 INFO - "platform": "ubuntu64_hw", 04:31:42 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:31:42 INFO - "branch": "mozilla-aurora", 04:31:42 INFO - "repo_path": "releases/mozilla-aurora", 04:31:42 INFO - "revision": "fb650a44de9ebb79104dd29b9534827398bf40de", 04:31:42 INFO - "stage_platform": "linux64-pgo", 04:31:42 INFO - "builduid": "e696099f82a842cd89f1f09181473898", 04:31:42 INFO - "slavebuilddir": "test" 04:31:42 INFO - } 04:31:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 04:31:42 INFO - Running post-action listener: _resource_record_post_action 04:31:42 INFO - ##### 04:31:42 INFO - ##### Finished read-buildbot-config step (success) 04:31:42 INFO - ##### 04:31:42 INFO - ##### 04:31:42 INFO - ##### Running download-and-extract step. 04:31:42 INFO - ##### 04:31:42 INFO - Running pre-action listener: _resource_record_pre_action 04:31:42 INFO - Running main action method: download_and_extract 04:31:42 INFO - mkdir: /builds/slave/test/build/tests 04:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:42 INFO - https://queue.taskcluster.net/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:31:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:31:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:31:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:31:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:31:42 INFO - Downloaded 1361 bytes. 04:31:42 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:31:42 INFO - Using the following test package requirements: 04:31:42 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 04:31:42 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:31:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:31:42 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:31:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:31:42 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:31:42 INFO - u'jsshell-linux-x86_64.zip'], 04:31:42 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:31:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:31:42 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 04:31:42 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:31:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:31:42 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:31:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:31:42 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:31:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:31:42 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:31:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:31:42 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:42 INFO - https://queue.taskcluster.net/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:31:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:31:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:31:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:31:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:31:43 INFO - Downloaded 24422297 bytes. 04:31:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:31:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:31:45 INFO - Return code: 0 04:31: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 04:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:45 INFO - https://queue.taskcluster.net/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:31:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:31:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:31:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:31:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:31:46 INFO - Downloaded 24422297 bytes. 04:31:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:31:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:31:48 INFO - Return code: 0 04:31:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:48 INFO - https://queue.taskcluster.net/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:31:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 04:31:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 04:31:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 04:31:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:31:49 INFO - Downloaded 10833369 bytes. 04:31:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:31:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:31:49 INFO - Return code: 0 04:31:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:49 INFO - https://queue.taskcluster.net/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:31:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:31:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:31:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:31:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:31:53 INFO - Downloaded 62813800 bytes. 04:31:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:31:53 INFO - mkdir: /builds/slave/test/properties 04:31:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:31:53 INFO - Writing to file /builds/slave/test/properties/build_url 04:31:53 INFO - Contents: 04:31:53 INFO - build_url:https://queue.taskcluster.net/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:31:53 INFO - Running post-action listener: _resource_record_post_action 04:31:53 INFO - Running post-action listener: set_extra_try_arguments 04:31:53 INFO - ##### 04:31:53 INFO - ##### Finished download-and-extract step (success) 04:31:53 INFO - ##### 04:31:53 INFO - ##### 04:31:53 INFO - ##### Running populate-webroot step. 04:31:53 INFO - ##### 04:31:53 INFO - Running pre-action listener: _resource_record_pre_action 04:31:53 INFO - Running main action method: populate_webroot 04:31:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:31:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:31:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:31:53 INFO - '--tppagecycles', 04:31:53 INFO - '7'], 04:31:53 INFO - 'tests': ['tsvgm']}}, 04:31:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:31:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:31:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:31:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:31:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:31:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:31:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:53 INFO - 'talos_options': ['--disable-e10s'], 04:31:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:53 INFO - 'talos_options': ['--disable-e10s'], 04:31:53 INFO - 'tests': ['damp', 'tps']}, 04:31:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:53 INFO - 'tests': ['damp', 'tps']}, 04:31:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:31:53 INFO - 'tests': ['dromaeo_dom']}, 04:31:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:31:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:31:53 INFO - 'tests': ['a11yr', 04:31:53 INFO - 'ts_paint', 04:31:53 INFO - 'tpaint', 04:31:53 INFO - 'sessionrestore', 04:31:53 INFO - 'sessionrestore_no_auto_restore', 04:31:53 INFO - 'tabpaint']}, 04:31:53 INFO - 'other-e10s': {'tests': ['a11yr', 04:31:53 INFO - 'ts_paint', 04:31:53 INFO - 'tpaint', 04:31:53 INFO - 'sessionrestore', 04:31:53 INFO - 'sessionrestore_no_auto_restore', 04:31:53 INFO - 'tabpaint']}, 04:31:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:31:53 INFO - 'ts_paint', 04:31:53 INFO - 'tpaint', 04:31:53 INFO - 'sessionrestore', 04:31:53 INFO - 'sessionrestore_no_auto_restore', 04:31:53 INFO - 'tabpaint']}, 04:31:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:31:53 INFO - 'ts_paint', 04:31:53 INFO - 'tpaint', 04:31:53 INFO - 'sessionrestore', 04:31:53 INFO - 'sessionrestore_no_auto_restore', 04:31:53 INFO - 'tabpaint']}, 04:31:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:31:53 INFO - 'tests': ['a11yr', 04:31:53 INFO - 'ts_paint', 04:31:53 INFO - 'tpaint', 04:31:53 INFO - 'sessionrestore', 04:31:53 INFO - 'sessionrestore_no_auto_restore', 04:31:53 INFO - 'tabpaint']}, 04:31:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:31:53 INFO - 'tests': ['a11yr', 04:31:53 INFO - 'ts_paint', 04:31:53 INFO - 'tpaint', 04:31:53 INFO - 'sessionrestore', 04:31:53 INFO - 'sessionrestore_no_auto_restore', 04:31:53 INFO - 'tabpaint']}, 04:31:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:31:53 INFO - 'tests': ['tsvgx', 04:31:53 INFO - 'tsvgr_opacity', 04:31:53 INFO - 'tart', 04:31:53 INFO - 'tscrollx', 04:31:53 INFO - 'cart']}, 04:31:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:31:53 INFO - 'tsvgr_opacity', 04:31:53 INFO - 'tart', 04:31:53 INFO - 'tscrollx', 04:31:53 INFO - 'cart']}, 04:31:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:53 INFO - 'talos_options': ['--disable-e10s'], 04:31:53 INFO - 'tests': ['tp5o']}, 04:31:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:53 INFO - 'tests': ['tp5o']}, 04:31:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:53 INFO - 'talos_options': ['--disable-e10s', 04:31:53 INFO - '--xperf_path', 04:31:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:53 INFO - 'tests': ['tp5n']}, 04:31:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:53 INFO - 'talos_options': ['--xperf_path', 04:31:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:53 INFO - 'tests': ['tp5n']}}, 04:31:53 INFO - 'talos.zip': {'path': '', 04:31:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:31:53 INFO - Running post-action listener: _resource_record_post_action 04:31:53 INFO - ##### 04:31:53 INFO - ##### Finished populate-webroot step (success) 04:31:53 INFO - ##### 04:31:53 INFO - ##### 04:31:53 INFO - ##### Running create-virtualenv step. 04:31:53 INFO - ##### 04:31:53 INFO - Running pre-action listener: _resource_record_pre_action 04:31:53 INFO - Running main action method: create_virtualenv 04:31:53 INFO - Creating virtualenv /builds/slave/test/build/venv 04:31:53 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:31:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:31:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:31:53 INFO - Using real prefix '/usr' 04:31:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:31:54 INFO - Installing distribute.............................................................................................................................................................................................done. 04:31:56 INFO - Installing pip.................done. 04:31:56 INFO - Return code: 0 04:31:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6cfead5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1143020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d52e0>, '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 0x1141140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11415d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1467113499.862650-567041491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:31:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:31:56 INFO - Using env: {'DISPLAY': ':0', 04:31:56 INFO - 'HOME': '/home/cltbld', 04:31:56 INFO - 'LANG': 'en_US.UTF-8', 04:31:56 INFO - 'LANGUAGE': 'en_US:en', 04:31:56 INFO - 'LOGNAME': 'cltbld', 04:31:56 INFO - 'MAIL': '/var/mail/cltbld', 04:31:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:56 INFO - 'MOZ_NO_REMOTE': '1', 04:31:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:56 INFO - 'NO_EM_RESTART': '1', 04:31:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:56 INFO - 'PWD': '/builds/slave/test', 04:31:56 INFO - 'SHELL': '/bin/bash', 04:31:56 INFO - 'SHLVL': '1', 04:31:56 INFO - 'TERM': 'linux', 04:31:56 INFO - 'TMOUT': '86400', 04:31:56 INFO - 'USER': 'cltbld', 04:31:56 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1467113499.862650-567041491', 04:31:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:56 INFO - '_': '/tools/buildbot/bin/python'} 04:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:31:56 INFO - Cleaning up... 04:31:56 INFO - Return code: 0 04:31:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6cfead5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1143020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d52e0>, '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 0x1141140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11415d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1467113499.862650-567041491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:31:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:31:56 INFO - Using env: {'DISPLAY': ':0', 04:31:56 INFO - 'HOME': '/home/cltbld', 04:31:56 INFO - 'LANG': 'en_US.UTF-8', 04:31:56 INFO - 'LANGUAGE': 'en_US:en', 04:31:56 INFO - 'LOGNAME': 'cltbld', 04:31:56 INFO - 'MAIL': '/var/mail/cltbld', 04:31:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:56 INFO - 'MOZ_NO_REMOTE': '1', 04:31:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:56 INFO - 'NO_EM_RESTART': '1', 04:31:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:56 INFO - 'PWD': '/builds/slave/test', 04:31:56 INFO - 'SHELL': '/bin/bash', 04:31:56 INFO - 'SHLVL': '1', 04:31:56 INFO - 'TERM': 'linux', 04:31:56 INFO - 'TMOUT': '86400', 04:31:56 INFO - 'USER': 'cltbld', 04:31:56 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1467113499.862650-567041491', 04:31:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:56 INFO - '_': '/tools/buildbot/bin/python'} 04:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:56 INFO - Downloading/unpacking psutil>=3.1.1 04:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:31:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:31:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:31:58 INFO - Installing collected packages: psutil 04:31:58 INFO - Running setup.py install for psutil 04:31:58 INFO - building 'psutil._psutil_linux' extension 04:31:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:31:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:31:59 INFO - building 'psutil._psutil_posix' extension 04:31:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:31:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:31:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:31:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:31:59 INFO - Successfully installed psutil 04:31:59 INFO - Cleaning up... 04:31:59 INFO - Return code: 0 04:31:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6cfead5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1143020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d52e0>, '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 0x1141140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11415d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1467113499.862650-567041491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:31:59 INFO - Using env: {'DISPLAY': ':0', 04:31:59 INFO - 'HOME': '/home/cltbld', 04:31:59 INFO - 'LANG': 'en_US.UTF-8', 04:31:59 INFO - 'LANGUAGE': 'en_US:en', 04:31:59 INFO - 'LOGNAME': 'cltbld', 04:31:59 INFO - 'MAIL': '/var/mail/cltbld', 04:31:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:59 INFO - 'MOZ_NO_REMOTE': '1', 04:31:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:59 INFO - 'NO_EM_RESTART': '1', 04:31:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:59 INFO - 'PWD': '/builds/slave/test', 04:31:59 INFO - 'SHELL': '/bin/bash', 04:31:59 INFO - 'SHLVL': '1', 04:31:59 INFO - 'TERM': 'linux', 04:31:59 INFO - 'TMOUT': '86400', 04:31:59 INFO - 'USER': 'cltbld', 04:31:59 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1467113499.862650-567041491', 04:31:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:59 INFO - '_': '/tools/buildbot/bin/python'} 04:31:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:32:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:32:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:32:01 INFO - Installing collected packages: mozsystemmonitor 04:32:01 INFO - Running setup.py install for mozsystemmonitor 04:32:01 INFO - Successfully installed mozsystemmonitor 04:32:01 INFO - Cleaning up... 04:32:01 INFO - Return code: 0 04:32:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:01 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 0x7f6cfead5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1143020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d52e0>, '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 0x1141140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11415d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1467113499.862650-567041491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:32:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:32:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:32:01 INFO - Using env: {'DISPLAY': ':0', 04:32:01 INFO - 'HOME': '/home/cltbld', 04:32:01 INFO - 'LANG': 'en_US.UTF-8', 04:32:01 INFO - 'LANGUAGE': 'en_US:en', 04:32:01 INFO - 'LOGNAME': 'cltbld', 04:32:01 INFO - 'MAIL': '/var/mail/cltbld', 04:32:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:01 INFO - 'MOZ_NO_REMOTE': '1', 04:32:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:01 INFO - 'NO_EM_RESTART': '1', 04:32:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:01 INFO - 'PWD': '/builds/slave/test', 04:32:01 INFO - 'SHELL': '/bin/bash', 04:32:01 INFO - 'SHLVL': '1', 04:32:01 INFO - 'TERM': 'linux', 04:32:01 INFO - 'TMOUT': '86400', 04:32:01 INFO - 'USER': 'cltbld', 04:32:01 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1467113499.862650-567041491', 04:32:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:01 INFO - '_': '/tools/buildbot/bin/python'} 04:32:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:01 INFO - Downloading/unpacking jsonschema==2.5.1 04:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:32:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:04 INFO - Downloading functools32-3.2.3-2.tar.gz 04:32:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:32:04 INFO - warning: no files found matching '*.txt' 04:32:04 INFO - no previously-included directories found matching 'build' 04:32:04 INFO - no previously-included directories found matching 'dist' 04:32:04 INFO - no previously-included directories found matching '.git*' 04:32:04 INFO - Installing collected packages: jsonschema, functools32 04:32:04 INFO - Running setup.py install for functools32 04:32:04 INFO - warning: no files found matching '*.txt' 04:32:04 INFO - no previously-included directories found matching 'build' 04:32:04 INFO - no previously-included directories found matching 'dist' 04:32:04 INFO - no previously-included directories found matching '.git*' 04:32:04 INFO - Successfully installed jsonschema functools32 04:32:04 INFO - Cleaning up... 04:32:04 INFO - Return code: 0 04:32:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:32:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:04 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 0x7f6cfead5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1143020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d52e0>, '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 0x1141140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11415d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1467113499.862650-567041491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:32:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:32:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:32:04 INFO - Using env: {'DISPLAY': ':0', 04:32:04 INFO - 'HOME': '/home/cltbld', 04:32:04 INFO - 'LANG': 'en_US.UTF-8', 04:32:04 INFO - 'LANGUAGE': 'en_US:en', 04:32:04 INFO - 'LOGNAME': 'cltbld', 04:32:04 INFO - 'MAIL': '/var/mail/cltbld', 04:32:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:04 INFO - 'MOZ_NO_REMOTE': '1', 04:32:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:04 INFO - 'NO_EM_RESTART': '1', 04:32:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:04 INFO - 'PWD': '/builds/slave/test', 04:32:04 INFO - 'SHELL': '/bin/bash', 04:32:04 INFO - 'SHLVL': '1', 04:32:04 INFO - 'TERM': 'linux', 04:32:04 INFO - 'TMOUT': '86400', 04:32:04 INFO - 'USER': 'cltbld', 04:32:04 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1467113499.862650-567041491', 04:32:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:04 INFO - '_': '/tools/buildbot/bin/python'} 04:32:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:04 INFO - Downloading/unpacking blobuploader==1.2.4 04:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:06 INFO - Downloading blobuploader-1.2.4.tar.gz 04:32:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:32:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:32:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:07 INFO - Downloading docopt-0.6.1.tar.gz 04:32:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:32:07 INFO - Installing collected packages: blobuploader, requests, docopt 04:32:07 INFO - Running setup.py install for blobuploader 04:32:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:32:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:32:07 INFO - Running setup.py install for requests 04:32:07 INFO - Running setup.py install for docopt 04:32:07 INFO - Successfully installed blobuploader requests docopt 04:32:07 INFO - Cleaning up... 04:32:07 INFO - Return code: 0 04:32:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32: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')]} 04:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32: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')]} 04:32:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:07 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 0x7f6cfead5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1143020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d52e0>, '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 0x1141140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11415d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1467113499.862650-567041491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:32:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:32:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:32:07 INFO - Using env: {'DISPLAY': ':0', 04:32:07 INFO - 'HOME': '/home/cltbld', 04:32:07 INFO - 'LANG': 'en_US.UTF-8', 04:32:07 INFO - 'LANGUAGE': 'en_US:en', 04:32:07 INFO - 'LOGNAME': 'cltbld', 04:32:07 INFO - 'MAIL': '/var/mail/cltbld', 04:32:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:07 INFO - 'MOZ_NO_REMOTE': '1', 04:32:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:07 INFO - 'NO_EM_RESTART': '1', 04:32:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:07 INFO - 'PWD': '/builds/slave/test', 04:32:07 INFO - 'SHELL': '/bin/bash', 04:32:07 INFO - 'SHLVL': '1', 04:32:07 INFO - 'TERM': 'linux', 04:32:07 INFO - 'TMOUT': '86400', 04:32:07 INFO - 'USER': 'cltbld', 04:32:07 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1467113499.862650-567041491', 04:32:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:07 INFO - '_': '/tools/buildbot/bin/python'} 04:32:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:32:07 INFO - Running setup.py (path:/tmp/pip-w2ok8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:32:08 INFO - Running setup.py (path:/tmp/pip-rOpyc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:32:08 INFO - Running setup.py (path:/tmp/pip-VpjLnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:32:08 INFO - Running setup.py (path:/tmp/pip-sNhlak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:32:08 INFO - Running setup.py (path:/tmp/pip-qQBt6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:32:08 INFO - Running setup.py (path:/tmp/pip-fpNRmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:32:08 INFO - Running setup.py (path:/tmp/pip-24Enqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:32:08 INFO - Running setup.py (path:/tmp/pip-YQd2r6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:32:08 INFO - Running setup.py (path:/tmp/pip-mQNVCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:32:08 INFO - Running setup.py (path:/tmp/pip-IyfA0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:32:08 INFO - Running setup.py (path:/tmp/pip-Id3cks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:32:08 INFO - Running setup.py (path:/tmp/pip-zQEptt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:32:08 INFO - Running setup.py (path:/tmp/pip-gTzpMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:32:08 INFO - Running setup.py (path:/tmp/pip-8h37Cw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:09 INFO - Running setup.py (path:/tmp/pip-p0vgfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:32:09 INFO - Running setup.py (path:/tmp/pip-TQjcqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:32:09 INFO - Running setup.py (path:/tmp/pip-VvkLEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:32:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:32:09 INFO - Running setup.py install for manifestparser 04:32:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:32:09 INFO - Running setup.py install for mozcrash 04:32:09 INFO - Running setup.py install for mozdebug 04:32:09 INFO - Running setup.py install for mozdevice 04:32:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:32:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:32:09 INFO - Running setup.py install for mozfile 04:32:09 INFO - Running setup.py install for mozhttpd 04:32:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:32:09 INFO - Running setup.py install for mozinfo 04:32:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:32:09 INFO - Running setup.py install for mozInstall 04:32:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:32:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:32:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:32:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:32:10 INFO - Running setup.py install for mozleak 04:32:10 INFO - Running setup.py install for mozlog 04:32:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:32:10 INFO - Running setup.py install for moznetwork 04:32:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:32:10 INFO - Running setup.py install for mozprocess 04:32:10 INFO - Running setup.py install for mozprofile 04:32:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:32:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:32:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:32:10 INFO - Running setup.py install for mozrunner 04:32:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:32:10 INFO - Running setup.py install for mozscreenshot 04:32:10 INFO - Running setup.py install for moztest 04:32:10 INFO - Running setup.py install for mozversion 04:32:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:32:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:32:10 INFO - Cleaning up... 04:32:11 INFO - Return code: 0 04:32:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:11 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 0x7f6cfead5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1143020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d52e0>, '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 0x1141140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11415d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1467113499.862650-567041491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:32:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:32:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:32:11 INFO - Using env: {'DISPLAY': ':0', 04:32:11 INFO - 'HOME': '/home/cltbld', 04:32:11 INFO - 'LANG': 'en_US.UTF-8', 04:32:11 INFO - 'LANGUAGE': 'en_US:en', 04:32:11 INFO - 'LOGNAME': 'cltbld', 04:32:11 INFO - 'MAIL': '/var/mail/cltbld', 04:32:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:11 INFO - 'MOZ_NO_REMOTE': '1', 04:32:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:11 INFO - 'NO_EM_RESTART': '1', 04:32:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:11 INFO - 'PWD': '/builds/slave/test', 04:32:11 INFO - 'SHELL': '/bin/bash', 04:32:11 INFO - 'SHLVL': '1', 04:32:11 INFO - 'TERM': 'linux', 04:32:11 INFO - 'TMOUT': '86400', 04:32:11 INFO - 'USER': 'cltbld', 04:32:11 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1467113499.862650-567041491', 04:32:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:11 INFO - '_': '/tools/buildbot/bin/python'} 04:32:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:32:11 INFO - Running setup.py (path:/tmp/pip-CCyVqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:32:11 INFO - Running setup.py (path:/tmp/pip-cBpefU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:32:11 INFO - Running setup.py (path:/tmp/pip-V3Nda9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:32:11 INFO - Running setup.py (path:/tmp/pip-I9TkLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:32:11 INFO - Running setup.py (path:/tmp/pip-NgtB6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:32:11 INFO - Running setup.py (path:/tmp/pip-Guqg8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:32:11 INFO - Running setup.py (path:/tmp/pip-ehe926-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:32:11 INFO - Running setup.py (path:/tmp/pip-wnsxTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:32:11 INFO - Running setup.py (path:/tmp/pip-3gwcBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:32:11 INFO - Running setup.py (path:/tmp/pip-bjGsXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:32:11 INFO - Running setup.py (path:/tmp/pip-IzrtrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:32:12 INFO - Running setup.py (path:/tmp/pip-dh8LJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:32:12 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)) 04:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:32:12 INFO - Running setup.py (path:/tmp/pip-HavZ4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:32:12 INFO - Running setup.py (path:/tmp/pip-SKZ2Fq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:32:12 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)) 04:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:12 INFO - Running setup.py (path:/tmp/pip-i4kpnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:32:12 INFO - Running setup.py (path:/tmp/pip-Fghl8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:32:12 INFO - Running setup.py (path:/tmp/pip-4_ncwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:32:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:32: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 04:32: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 04:32: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 04:32: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 04:32: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 04:32: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 04:32:14 INFO - Downloading blessings-1.6.tar.gz 04:32:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:32:14 INFO - Installing collected packages: blessings 04:32:14 INFO - Running setup.py install for blessings 04:32:14 INFO - Successfully installed blessings 04:32:14 INFO - Cleaning up... 04:32:14 INFO - Return code: 0 04:32:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:32:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:32:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:32:14 INFO - Reading from file tmpfile_stdout 04:32:14 INFO - Current package versions: 04:32:14 INFO - argparse == 1.2.1 04:32:14 INFO - blessings == 1.6 04:32:14 INFO - blobuploader == 1.2.4 04:32:14 INFO - docopt == 0.6.1 04:32:14 INFO - functools32 == 3.2.3-2 04:32:14 INFO - jsonschema == 2.5.1 04:32:14 INFO - manifestparser == 1.1 04:32:14 INFO - mozInstall == 1.12 04:32:14 INFO - mozcrash == 0.17 04:32:14 INFO - mozdebug == 0.1 04:32:14 INFO - mozdevice == 0.48 04:32:14 INFO - mozfile == 1.2 04:32:14 INFO - mozhttpd == 0.7 04:32:14 INFO - mozinfo == 0.9 04:32:14 INFO - mozleak == 0.1 04:32:14 INFO - mozlog == 3.2 04:32:14 INFO - moznetwork == 0.27 04:32:14 INFO - mozprocess == 0.22 04:32:14 INFO - mozprofile == 0.28 04:32:14 INFO - mozrunner == 6.11 04:32:14 INFO - mozscreenshot == 0.1 04:32:14 INFO - mozsystemmonitor == 0.3 04:32:14 INFO - moztest == 0.7 04:32:14 INFO - mozversion == 1.4 04:32:14 INFO - psutil == 3.1.1 04:32:14 INFO - requests == 1.2.3 04:32:14 INFO - wsgiref == 0.1.2 04:32:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32: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')]} 04:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32: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')]} 04:32:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:14 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 0x7f6cfead5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1143020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d52e0>, '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 0x1141140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11415d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1467113499.862650-567041491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:32:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:32:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:32:14 INFO - Using env: {'DISPLAY': ':0', 04:32:14 INFO - 'HOME': '/home/cltbld', 04:32:14 INFO - 'LANG': 'en_US.UTF-8', 04:32:14 INFO - 'LANGUAGE': 'en_US:en', 04:32:14 INFO - 'LOGNAME': 'cltbld', 04:32:14 INFO - 'MAIL': '/var/mail/cltbld', 04:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:14 INFO - 'MOZ_NO_REMOTE': '1', 04:32:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:14 INFO - 'NO_EM_RESTART': '1', 04:32:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:14 INFO - 'PWD': '/builds/slave/test', 04:32:14 INFO - 'SHELL': '/bin/bash', 04:32:14 INFO - 'SHLVL': '1', 04:32:14 INFO - 'TERM': 'linux', 04:32:14 INFO - 'TMOUT': '86400', 04:32:14 INFO - 'USER': 'cltbld', 04:32:14 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1467113499.862650-567041491', 04:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:14 INFO - '_': '/tools/buildbot/bin/python'} 04:32:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:32:15 INFO - Cleaning up... 04:32:15 INFO - Return code: 0 04:32:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:15 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 0x7f6cfead5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1143020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d52e0>, '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 0x1141140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11415d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1467113499.862650-567041491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:32:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:32:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:32:15 INFO - Using env: {'DISPLAY': ':0', 04:32:15 INFO - 'HOME': '/home/cltbld', 04:32:15 INFO - 'LANG': 'en_US.UTF-8', 04:32:15 INFO - 'LANGUAGE': 'en_US:en', 04:32:15 INFO - 'LOGNAME': 'cltbld', 04:32:15 INFO - 'MAIL': '/var/mail/cltbld', 04:32:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:15 INFO - 'MOZ_NO_REMOTE': '1', 04:32:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:15 INFO - 'NO_EM_RESTART': '1', 04:32:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:15 INFO - 'PWD': '/builds/slave/test', 04:32:15 INFO - 'SHELL': '/bin/bash', 04:32:15 INFO - 'SHLVL': '1', 04:32:15 INFO - 'TERM': 'linux', 04:32:15 INFO - 'TMOUT': '86400', 04:32:15 INFO - 'USER': 'cltbld', 04:32:15 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1467113499.862650-567041491', 04:32:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:15 INFO - '_': '/tools/buildbot/bin/python'} 04:32:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:32:15 INFO - Cleaning up... 04:32:15 INFO - Return code: 0 04:32:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:15 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 0x7f6cfead5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1143020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d52e0>, '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 0x1141140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11415d0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1467113499.862650-567041491', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:32:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:32:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:32:15 INFO - Using env: {'DISPLAY': ':0', 04:32:15 INFO - 'HOME': '/home/cltbld', 04:32:15 INFO - 'LANG': 'en_US.UTF-8', 04:32:15 INFO - 'LANGUAGE': 'en_US:en', 04:32:15 INFO - 'LOGNAME': 'cltbld', 04:32:15 INFO - 'MAIL': '/var/mail/cltbld', 04:32:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:15 INFO - 'MOZ_NO_REMOTE': '1', 04:32:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:15 INFO - 'NO_EM_RESTART': '1', 04:32:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:15 INFO - 'PWD': '/builds/slave/test', 04:32:15 INFO - 'SHELL': '/bin/bash', 04:32:15 INFO - 'SHLVL': '1', 04:32:15 INFO - 'TERM': 'linux', 04:32:15 INFO - 'TMOUT': '86400', 04:32:15 INFO - 'USER': 'cltbld', 04:32:15 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1467113499.862650-567041491', 04:32:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:15 INFO - '_': '/tools/buildbot/bin/python'} 04:32:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:15 INFO - Downloading/unpacking flake8 04:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:32:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:32:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:32:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:32:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:32:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:32:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:32:18 INFO - no previously-included directories found matching 'docs/_build' 04:32:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:32:18 INFO - Running setup.py install for pep8 04:32:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:32:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:32:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:32:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:32:18 INFO - no previously-included directories found matching 'docs/_build' 04:32:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:32:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:32:18 INFO - Cleaning up... 04:32:18 INFO - Return code: 0 04:32:18 INFO - Running post-action listener: _resource_record_post_action 04:32:18 INFO - Running post-action listener: _start_resource_monitoring 04:32:18 INFO - Starting resource monitoring. 04:32:18 INFO - ##### 04:32:18 INFO - ##### Finished create-virtualenv step (success) 04:32:18 INFO - ##### 04:32:18 INFO - ##### 04:32:18 INFO - ##### Running install step. 04:32:18 INFO - ##### 04:32:18 INFO - Running pre-action listener: _resource_record_pre_action 04:32:18 INFO - Running main action method: install 04:32:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:32:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:32:18 INFO - Reading from file tmpfile_stdout 04:32:18 INFO - Detecting whether we're running mozinstall >=1.0... 04:32:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:32:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:32:18 INFO - Reading from file tmpfile_stdout 04:32:18 INFO - Output received: 04:32:18 INFO - Usage: mozinstall [options] installer 04:32:18 INFO - Options: 04:32:18 INFO - -h, --help show this help message and exit 04:32:18 INFO - -d DEST, --destination=DEST 04:32:18 INFO - Directory to install application into. [default: 04:32:18 INFO - "/builds/slave/test"] 04:32:18 INFO - --app=APP Application being installed. [default: firefox] 04:32:18 INFO - mkdir: /builds/slave/test/build/application 04:32:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:32:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:32:34 INFO - Reading from file tmpfile_stdout 04:32:34 INFO - Output received: 04:32:34 INFO - /builds/slave/test/build/application/firefox/firefox 04:32:34 INFO - Running post-action listener: _resource_record_post_action 04:32:34 INFO - ##### 04:32:34 INFO - ##### Finished install step (success) 04:32:34 INFO - ##### 04:32:34 INFO - ##### 04:32:34 INFO - ##### Running run-tests step. 04:32:34 INFO - ##### 04:32:34 INFO - Running pre-action listener: _resource_record_pre_action 04:32:34 INFO - Running main action method: run_tests 04:32:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:32:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:32:34 INFO - Python 2.7.3 04:32:34 INFO - Return code: 0 04:32:34 INFO - grabbing minidump binary from tooltool 04:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:34 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 0x11d52e0>, '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 0x1141140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11415d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:32:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:32:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:32:34 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:32:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:32:34 INFO - Return code: 0 04:32:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:32:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:32:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:32:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:32:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:32:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:32:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:32:35 INFO - Return code: 0 04:32:35 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/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 04:32:35 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/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 04:32:35 INFO - Using env: {'DISPLAY': ':0', 04:32:35 INFO - 'HOME': '/home/cltbld', 04:32:35 INFO - 'LANG': 'en_US.UTF-8', 04:32:35 INFO - 'LANGUAGE': 'en_US:en', 04:32:35 INFO - 'LOGNAME': 'cltbld', 04:32:35 INFO - 'MAIL': '/var/mail/cltbld', 04:32:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:32:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:32:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:35 INFO - 'MOZ_NO_REMOTE': '1', 04:32:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:32:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:35 INFO - 'NO_EM_RESTART': '1', 04:32:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:35 INFO - 'PWD': '/builds/slave/test', 04:32:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:32:35 INFO - 'SHELL': '/bin/bash', 04:32:35 INFO - 'SHLVL': '1', 04:32:35 INFO - 'TERM': 'linux', 04:32:35 INFO - 'TMOUT': '86400', 04:32:35 INFO - 'USER': 'cltbld', 04:32:35 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1467113499.862650-567041491', 04:32:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:35 INFO - '_': '/tools/buildbot/bin/python'} 04:32:35 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/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 04:32:35 INFO - mozversion application_buildid: 20160628015111 04:32:35 INFO - mozversion application_changeset: fb650a44de9ebb79104dd29b9534827398bf40de 04:32:35 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:32:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:32:35 INFO - mozversion application_name: Firefox 04:32:35 INFO - mozversion application_remotingname: firefox-dev 04:32:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:32:35 INFO - mozversion application_vendor: Mozilla 04:32:35 INFO - mozversion application_version: 49.0a2 04:32:35 INFO - mozversion platform_buildid: 20160628015111 04:32:35 INFO - mozversion platform_changeset: fb650a44de9ebb79104dd29b9534827398bf40de 04:32:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:32:35 INFO - mozversion platform_version: 49.0a2 04:32:35 INFO - using testdate: 1467113555 04:32:35 INFO - actual date: 1467113555 04:32:35 INFO - starting webserver on 'localhost:47729' 04:32:35 INFO - SUITE-START | Running 2 tests 04:32:35 INFO - TEST-START | dromaeo_css 04:32:35 INFO - operating with platform_type : linux_ 04:32:35 INFO - Initialising browser for dromaeo_css test... 04:32:35 INFO - TEST-INFO | started process 14757 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLYQPc_/profile http://localhost:47729/getInfo.html) 04:32:39 INFO - PROCESS | 14757 | __metrics Screen width/height:1600/1200 04:32:39 INFO - PROCESS | 14757 | colorDepth:24 04:32:39 INFO - PROCESS | 14757 | Browser inner width/height: 1024/697 04:32:39 INFO - PROCESS | 14757 | __metrics 04:32:40 ERROR - PROCESS | 14757 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:32:41 INFO - TEST-INFO | 14757: exit 0 04:32:41 INFO - Browser initialized. 04:32:41 INFO - Running cycle 1/1 for dromaeo_css test... 04:32:41 INFO - TEST-INFO | started process 14849 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLYQPc_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:32:53 INFO - PROCESS | 14849 | RSS: Main: 146255872 04:32:53 INFO - PROCESS | 14849 | 04:33:45 INFO - PROCESS | 14849 | 1467113625175 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:35:51 INFO - PROCESS | 14849 | Cycle 1(1): loaded http://localhost:47729/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47729/tests/dromaeo/cssquery-ext.html) 04:35:52 INFO - PROCESS | 14849 | RSS: Main: 270483456 04:35:52 INFO - PROCESS | 14849 | 04:38:55 INFO - PROCESS | 14849 | Cycle 1(1): loaded http://localhost:47729/tests/dromaeo/cssquery-ext.html (next: http://localhost:47729/tests/dromaeo/cssquery-jquery.html) 04:38:55 INFO - PROCESS | 14849 | RSS: Main: 222875648 04:38:55 INFO - PROCESS | 14849 | 04:41:57 INFO - PROCESS | 14849 | Cycle 1(1): loaded http://localhost:47729/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47729/tests/dromaeo/cssquery-mootools.html) 04:41:58 INFO - PROCESS | 14849 | RSS: Main: 237834240 04:41:58 INFO - PROCESS | 14849 | 04:45:00 INFO - PROCESS | 14849 | Cycle 1(1): loaded http://localhost:47729/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47729/tests/dromaeo/cssquery-prototype.html) 04:45:00 INFO - PROCESS | 14849 | RSS: Main: 237920256 04:45:00 INFO - PROCESS | 14849 | 04:48:03 INFO - PROCESS | 14849 | Cycle 1(1): loaded http://localhost:47729/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47729/tests/dromaeo/cssquery-yui.html) 04:48:03 INFO - PROCESS | 14849 | RSS: Main: 214728704 04:48:03 INFO - PROCESS | 14849 | 04:51:06 INFO - PROCESS | 14849 | Cycle 1(1): loaded http://localhost:47729/tests/dromaeo/cssquery-yui.html (next: http://localhost:47729/tests/dromaeo/cssquery-dojo.html) 04:51:06 INFO - PROCESS | 14849 | RSS: Main: 257556480 04:51:06 INFO - PROCESS | 14849 | 04:51:06 INFO - PROCESS | 14849 | __start_tp_report 04:51:06 INFO - PROCESS | 14849 | _x_x_mozilla_page_load 04:51:06 INFO - PROCESS | 14849 | _x_x_mozilla_page_load_details 04:51:06 INFO - PROCESS | 14849 | |i|pagename|runs| 04:51:06 INFO - PROCESS | 14849 | |0;dojo.html;3215.678432156783;3231.5960504936884;3250.138713240991;3260.0545841705894;3280.0979730574104;5023.874403139924;5111.56551693106;5122.436531981479;5125.513076257755;5144.9742751286285;4990.925136122961;5004.749762511878;5008.949910500894;5013.724245166523;5038.571721403685;4511.661625378093;4550.726956382611;4603.677742558022;4608.5852273295395;4619.168549661076;4536.9546304537025;4591.47198072221;4637.814487420499;4640.2343613303765;4643.187442197602;4721.3390125382475;4728.1252968201;4743.35964644772;4750.453697824742;4773.880652983686;4512.729236245803;4697.765111744399;4715.316279139505;4735.81056757731;4780.187368147406;4390.429244198266;4639.721616702975;4655.627549796008;4659.603933665642;4703.529647035269;5000.649954503187;5049.949500504985;5049.949500505021;5056.039352523009;5056.519630635084;5191.766370513336;5490.066688662937;5497.615166938316;5501.669899806025;5502.9174562381595;5296.629235953485;5329.094054010828;5333.866653333659;5374.731263436813;5400.459954004607;5067.949320506785;5081.74591270435;5082.390113186404;5085.872853178663;5087.643864929457;5258.237555554423;5389.272448219519;5454.7818087276855;5477.863053423696;5482.862928426821;5270.446603106695;5329.934013197376;5336.799220175507;5358.97320513395;5361.678299302054;5381.596380271495;5384.811531596375;5402.540784033323;5406;5413.729313534308;5101.489851014943;5320.627556071116;5352.518273355417;5361.973190134025;5362.383325917492;5401.540869026177;5421.891562168814;5424.945750542523;5424.972875135599;5428;4233.534311225762;4248.299030659969;4259.23333799919;4272.273713468718;4276.700630955866;3752.0432289765936;3785;3802.4676545283683;3825.4835597194024;3871.05159235989;5110.8466745997675;5133.512316329943;5139.023585518739;5141.742912854343;5162.5095615916425;5370.489803468664;5373.892522149535;5378.677279363251;5382.461753824587;5409.188621706776;4944.629152813553;5115.462876397999;5148.407933087743;5150.0472412603785;5195.064888320063;4695.906081878344;4723.95276047242;4724.314974328703;4731.810727570927;4745.83389581363;5463.808766693147;5631.577631677641;5635.830925072254;5646.435356464321;5656.490915817596;5325.440828713007;5350.759215835219;5360.115580929103;5385.38068122171;5412.539934105645;5598.608097433141;5604.187392828098;5605.075162598288;5614.214010038516;5618.747156378055;5155.819546315861;5272.604554658493;5327.600429967845;5338.3060202173465;5364.114921038141;5331.973340133274;5404.297441332602;5410.3507579090765;5413.675179489243;5424.376196737426;5239.161734122522;5255.421903590525;5264;5269.1832765921345;5294.2852714883;4953.455119936876;5158.561522270649;5196.038732834438;5272.499112584298;5278.8944221116135;5164.586833053271;5185.403678577012;5185.637005409585;5189.377274727057;5200.765965531636;5268.473152684701;5275.89448211026;5296.523312901857;5314.601404894571;5316.149416093561;5018.197088465828;5156.329677141947;5174.301469301596;5182.041322355376;5203.427622961395 04:51:06 INFO - PROCESS | 14849 | |1;ext.html;590.1442907783712;629.2103410220175;640.1326202994942;655.4068567946009;658.8879890418629;32894.83552582237;35637.82181089094;35687.643123568756;35967.28065438696;36115.81942090289;35957;36601.45097823535;45555.31667024989;47484;47635.761821190936;8952.910470895273;9066;9075.047120052399;9075.455472671627;9087.863682044775;8965.462072275652;9045.321600879928;9051.502167380791;9056.094390560957;9057.95471022644;8163.632636531341;10678.51946662402;10924.781504369908;10931;11337.036351910097;10834.566617335297;10903.945480272549;10904.78190436187;10921.180911431635;10923.126149907988;8176.959115204386;10287.279890407599;10786.137109031337;10817.459127043616;10854.837177442345;41186.794066029775;45411.091778164584;45477.77261113673;45499.31751023737;45534.08931821345;3449.827508624584;3465.4108801503803;3518.1204698825295;3522.330757156132;3891.9027024324337;33226;33342.83328583366;33841;33875.491867622004;34223.65776342255;3930.253251882133;3957.109650328653;3974.284628766821;4026.1142548639255;4153.460050193456;364030;364936;366225;366594;366935.16532417433;67146.328536714;67419.66290168518;67503;67606;67637.32362676409;68597.59908403183;68604.31395686079;68922.3107768926;68934.65532672405;69102.30897691059;18880.905595471933;19407.611847762964;19469.902650486656;19480.902595487216;19504.51238719015;13429.664258393423;13772.380242888894;13788.793168102486;14046;14582.270886455635;18006.92149662438;18272;19097.140628671466;19999.900000499903;20719.8964005179;7198.244184360671;7218.711251549984;7347.706091756377;7481.438892083115;7637.656305466267;1007.7732510185297;1047.7581639474201;1090.7654854206385;1154.7979103656826;1160.4255893332686;34040.82979585086;34849.47725784115;34984.475232871526;35000.82499587486;35349.46975795365;1123.5898896902572;1160.5589875847124;1163.2264544078093;1202.2846406388185;1219.4756254810338;17478.65042699139;18043.458696239133;18117;18121.63756724858;18145.637087258445;596914;601264;605293;605341;608074;63721;63940.68029659822;64154.6792266045;64282.35717642857;64516.67741661262;1330.767115754739;1381.5371850430217;1433.125793266107;1444.5088669852091;1462.700146469971;32173;34722.89408983683;34913.9525814226;35582.46626300556;35671.10822229465;52731;53154.73422632862;53220.2016969738;53239.20141197808;53287.20069199042;420364;423673;425189;427508.4498309954;427648;24883.502329953662;30086.398272034;30141.397172056873;30733.23166920845;31639.367212656078;51615.74192129015;51685.48314516957;52208.73895630497;52373;52795.47204527906;41285.58714412817;42754.57245427506;42805.78597106995;43356;43435.78282108569;41706.165876682906;41803.16393672171;41963.29847630669;42338.5766142347;42768.57231427646;42616.78691606522;43211;43481.78259108684;43931.34102988522;44147;35826;37753.81123094367;37927.81036094802;38296;38952.220955581295;29040.854795725885;29065.273368165967;29112;29131.85434072816;29296.853515732284 04:51:06 INFO - PROCESS | 14849 | |2;jquery.html;428.51149689354133;430.42021338058004;432.17023315234746;434.0602595381;441.1794063042742;18292.99999999998;19051.23795048198;20031.59936801265;20128.698069528968;20143.093560789763;18520.444386668387;19038.61922761544;19249.61500769984;19286.228550857948;19294.80705192951;4921.557059864612;5266.157414813631;5268.894622107575;5326.201069839516;5332.626716129873;5207.375114986207;5221.660592061523;5268.525832675058;5447.12845944649;5449.182622606601;5415.9458405415835;5425.294711687475;5427.511523962842;5449.04641687705;5450.5639548836;5293.417724050351;5411.540019098381;5943;5949.137375080632;5952.940470595282;5359.812406565751;5378.2470454136455;5381.112116500773;5382.9730851345885;5391.919121213185;14354.425822967069;18222.90888545562;18572.814271857245;24077;24135.396615084588;2408.1812183857573;2433.245693834917;2463.876806159703;2532.9240122796346;2971.658259300165;10709;10843.240973131884;10980.450977451095;11388.943055284753;13925.303734813218;1958.7943265957012;2013.134352228541;2020.8888511131881;2027.979720202794;2039.51051747581;81780;83726;83739;84182;85003.57498212469;9727.756806079904;10291.94854025725;10475.895241047645;10476.0571548561;10569.947150264354;14291.928540357232;14437.278136093153;14449.133052016912;14494.492692755703;14603.415863365346;8207.589620518951;8383.413161078666;8434.072252052269;8491.448055876348;8507.787305317417;8416.873746893802;8468.661253549912;8483.915160848435;8497.065322814486;8502;4312.54718254585;4385;4413.823447062082;4434.157510073141;4493;2040.9081591328427;2084.78109798472;2088.2064815370063;2108.9578208435746;2157.492989147549;996.930214884951;1078.6710053433778;1095.638439315024;1098.4397957041806;1142.4459137318395;18435.53911152232;18948.81051189498;19538.413847584594;19738.40784776459;20041.599168016557;1035.4874337202982;1061.4851796878509;1068.636663534402;1073.0503504398664;1082.3397727386289;10668.573257069631;10980;11080.944595276973;11142.442877856074;11241.21311508203;554696;555425;557284;561173;566581;103149;106554.46722766336;106947.46526267318;107075;108056;1045.513836066233;1049.5854137615752;1099.4392859641641;1109.14595761265;1118.8937050980144;14798.48205312852;17128.57178570546;17606;17683.115844207994;17711.901537481244;40570;41085.151168196906;41134.794326028175;42086.1582768349;42711.14577708491;61190.69404652948;62033.68983155236;62198.0670289937;62454.37545624486;63090.05364919622;8287.295579875778;8649.740507784776;8900.465972041698;9009.23421509179;9032.683856065007;9600.519974001412;12844.357782111045;13191.274479903697;13441.462341506622;13619.114757540729;11330.60342887995;11888;11927.94036029849;11967.222130561486;12038.518459261531;11256.493457794255;11499.252548584314;11549.191556590958;11676.591319303783;11779;10879.891201087888;11412.144089193178;11505.712357190803;11673.416329183678;12496.437660305126;9081.228095611947;12116.091293153226;12807.487700491876;12971.740565188833;13408.32958352098;11222.382768947786;12243.75512489763;12252.571160009356;12305.138640295094;12623.305718185587 04:51:06 INFO - PROCESS | 14849 | |3;mootools.html;1372.4098637585835;1553.4951140879214;1602.1028224194451;1779.5995900922294;1869.1215128889426;8162.8367432651385;8860.291176705865;8993.640254389824;9006.639734410615;9235.90764092359;8870.112988701143;9067.183953444188;9075.546222688856;9080.0465951075;9113.453192808436;2368.9407764805887;2388.199953015742;2389.462370966536;2389.7012873390827;2389.9603672402473;2366.5503554324623;2379.131616959806;2419.5644783938883;2423.7333893271725;2427.1262345555588;2376.8217383696206;2383.2969274064194;2390.5816482115647;2423.151896836102;2423.7881059470265;2341.2742049964395;2353.235198560466;2372.9288121356385;2377.0967032527615;2377.607694730376;2284.657301404786;2317.5249073939804;2334.031376978552;2336.9649455258186;2337.6844126043106;7695;8964.372493925428;9097.408668436598;9206.53967301639;9211.861822072675;5223.895522089575;5402.621816472849;5544.695041772701;5550.888982220374;5554.1391084381585;3407.9659203408146;3461.4288642373976;3520.8239588020497;3523.348180586574;3554.7689400188906;1066.477426061232;1097.7969075721016;1106.1593189176203;1125.5104029747085;1146.5700362364114;13319;13647.181169129784;13666.248356340397;13677.521286755014;13679.179249244977;4865.5864251539015;4886.315915771795;4902.779374928136;4959.677620954626;4989.750512474362;11308.491117899714;11384.658460246206;11385.373804440835;11411.828822567668;11438.656840294805;5605.691686957257;5612.831615051555;5613.8596535086135;5615.185798059259;5616.185653080281;4954.3311652926395;5022.673526220784;5075.5178258065425;5085.084684756705;5148.382194136728;3970.4441378207075;3989.082511022481;4002.3796311571755;4060.2285565743005;4155.501339839238;1203.4584437003384;1224.1614494071412;1238.993805030969;1241.714405686697;1259.2066997791333;786.8819677048489;834.1533343656193;989.4656885281867;997.8104160209537;1001.0940099210227;5483.369412517612;5658.603897727202;5716.791143308385;5761.8559536011935;5787.971060144672;430.5178200415492;441.5231549926136;446.92849144136784;451.7786284720463;464.6933024204009;4073.205724883619;4143.129942712064;4147.730397524211;4192.7065105442325;4193.412922190896;11598.71003224926;11992.580259690869;12067.094967877445;12071.517139314328;12073.91334779874;11346.092312614972;11865.584704535473;11870.34713090771;11873;12015.098867584791;8787.253083487847;8861.424007439624;8964.551772411354;8987.236084932854;8989.910100898907;6327.841803954938;6369.9681501592195;6461;6480.189976252968;6543.378379053982;10821.837672435076;10849.799309203647;11099.334039957628;11173.217874748689;11294;11311;11422.543098275975;11508.36703981289;11607.883921160681;11659.650210493699;8138.064122625974;8218.876716849132;8234.629441675259;8237.217464340878;8507.617157228064;9322.766930826783;9414.2468602513;9492.240620750461;9509.762255943657;9522.381045232038;8109.3917956152345;8218.589070546568;8219.630116644885;8279.37904657141;8461.61922713467;8259.504429734236;8363.289120424588;8381.16188381157;8406.03330616987;8433.704820331259;7806.180351063056;7862.842743145219;7866.488678235896;7937.126916039347;7949.244821741925;5187.688738675692;5221.112410890234;5320.707361095177;5355;5410.296661433988;5496.285482887359;5593.384727679871;5606.355269144101;5637.295338082739;5688 04:51:06 INFO - PROCESS | 14849 | |4;prototype.html;340.9437442821933;346.82658670664665;350.4637904006869;350.95437593112894;354.80485732846927;4912.926306105412;4949.727764972934;4952.653314268003;4963.553280204781;4967.478414766447;4851.587615052716;4900;4902.166631672615;4902.730349830758;4917.778699958501;3721.6278372162838;3876.1666241758016;3950.2297052074855;3964.682825373963;3980.621840925122;3881.7282790204695;3895.4935858338517;3914.3149948758996;3914.451976723261;3919.4316824060493;3892.766434013954;3897.824597893102;3904.804759762015;3909.1790723948006;3910.687145028405;3694.833732482045;3785.5078839750795;3915.6671682906986;3935.409688546741;3939.1924655445564;3488.372093023255;3493.1616412061176;3499.160201551609;3502.2820321833965;3507.7369197310304;4593.862184134481;4731.645126615517;4758.191107511731;4772.093302272557;4773.925866680004;4346.956530434687;4373.606375426227;4417.911641767147;4426.7122637028815;4454.910901781978;5057.519535644108;5061.620378471593;5079.517445842639;5084.720340381277;5105.132127538327;3790.507234059582;3794.487744154559;3800.1259710266518;3801.1257410795397;3825.196708691178;5013.849584512471;5258.789648414059;5270.39390470097;5271.235670827747;5272.6836389816735;3797.373433383461;3826.693864490834;3828.5260174832333;3838.3858582626644;3847.8076096195077;3892.785896775648;3908.726389152732;3912.960870391317;3927.489426374553;3937.110187110146;4208.884645568926;4385.758783266887;4395.472543294825;4416.337549367557;4446.643773649068;5102.566281866083;5114.43741188469;5119.769610367543;5137.12668846297;5137.563307118862;1330.1021810278023;1351.8242628458434;1352.114365090867;1359.6057143428493;1361.768499355112;843.9156084391511;887.8535041718173;888.546841111038;891.3315013739696;895.8700988356652;4540.704854184468;4550.453945526558;4575.313702944519;4583.702059366131;4603;4667.949711314927;4680.204365257914;4726.740029298353;4741.573258406691;4750.809967601257;4530.4110465639915;4861.440934292602;4884.877878053077;5013.749312534359;5024.748762561857;2749.3676454415595;2766.879413837399;2781.7218278172427;2783.958240626392;2784.331760377495;5326.280952071421;5393.83818485446;5481.738365672419;5482.342118945752;5486.61593688438;5353.491418315254;5361.919571206435;5362.310872075283;5375.3280839895015;5376.301080859542;5432.185172224198;5441.646292991022;5444.591655625764;5446.222426562403;5464.890702185934;5064.290999260033;5199.4020687621405;5239.633225674166;5241.633085684118;5258.631895767413;5185.092608793521;5211.140161873249;5216.426193118678;5222.3472065991755;5229.346331708536;5440.510354068153;5440.782368705208;5457.7271136443815;5460.836174914759;5470.756989634231;3766.7023115898733;3875.2636998970106;3877.5928527504207;3878.8254528545717;3884.067823722343;5257.974694934451;5273.841784746463;5292.947070529245;5293.173855020012;5315.335583052119;5131.281620573048;5148.712821794551;5157.896842063063;5161.612879034163;5210.869728256824;5019.874503137451;5104.206774674376;5134.177367034798;5152.458991805806;5153.149730294459;5035.7985680572365;5048.368953880765;5059.87350316245;5096.23556466533;5114.488551145005;5197.9604079183555;5207;5220.817271395483;5225.895482090261;5230.34620672416;4809.927851082307;5087.87280317995;5099.592032637454;5119.308893299357;5154.974225128851 04:51:06 INFO - PROCESS | 14849 | |5;yui.html;780.1574299756264;785.1285073568334;816.0819078536646;854.8504011797936;858.2790456016944;15956.760648590265;17106.91446542767;17758.822411775895;18548.165332560035;18548.721769173473;15658.765118523203;15959.680806383894;16069.83930160701;16158.192090395463;16176.75734863978;721.2462976189868;852.6845067325098;870.5951732444412;872.2803686958254;874.4840544078992;868.6395146014428;869.8086420987404;873.2708188662443;873.8820259265013;874.1957399192726;909.8316811389881;911.3666002128523;911.4075850697067;911.5123408976199;911.6717981526646;748.3638906929094;880.7445840706188;904.1591320072363;907.7049958763363;908.7955210077746;659.156279961645;662.2185820731535;663.4427081251723;663.707968493866;664.0868805392586;16348;16381.426650067191;16397.262123204484;16467.258973346226;16477.83522164787;14544.27278636064;14684.926575367163;14836.25818709071;14920.701585968329;15117.697646047018;12866.806997895039;13023.28371939543;13050.15174013686;13640.249786261751;14553.345099470549;3888.51393575803;4132.752034877917;4149.294619914622;4233.767142807144;4235.343521754133;75437.62281188613;82103;82548.9999999994;83134.58432707858;83324;12112.757744845054;12660.936695316464;12768.489260429478;12879;12909.806352904714;24128.63807042896;24281.150159744324;24290.392740181283;24419.755802442105;24427.511449770904;8898.243649289754;9017.63929442828;9087.636494540144;9279.860802087975;9301.674441394518;5084.084864724311;5136.717480538607;5217.869553261123;5254.7635356409055;5446.373667028263;3719.9814000930364;3754.718396120302;3822.9808850956124;3824.598417166213;3832.5784163741964;601.2964831147568;618.8731310081422;636.3445650979498;640.5292110298926;663.8771827211981;684.8596037812237;819.5287709567023;828.8342331533718;831.08580561382;838.8532006898769;9909.20726341891;9968.651097211563;9988.750281243027;10021;10163.898361016296;729.901463302458;754.4869488747704;755.8119244786312;765.12775436003;814.7596459044596;4918.311436398907;4940.481249468826;5028.421731500925;5067.4932506749765;5293.682379057192;91086;93038;94223.52888235515;105968;122499.38750306191;90629;94778.52610736902;95373;95559.52220238854;96283.51858240664;87852.5607371959;88495.55752221326;88800.55599722089;89480;89874.55062724644;10130.898691012995;10299.794004119725;10427.582896684047;10460.947695261779;10474.423906685206;49951.75024125002;50075.499245007086;51223;51393.229101564255;51815.74092129666;67359.66320168368;67530;72547;74213.628931855;77560;14221.687202471277;14340.21128837924;14399.136051836924;14764.778528322298;15047;15580.454684086002;15801.68396632084;16036.278367473258;16204.27080781344;16221.188940553162;12781.679328823075;12986.675333116747;13616.18302901829;14403.92798036045;14569.635759106108;14233.857661423668;14422.927885360506;15311.387544498095;15449.613759656098;16197.190140492692;13339.465961414173;13734.93132534331;13856.515021974183;13879.236641984384;13921.651958700708;11310.717232068935;11633.360165190996;12028.338441385808;12056.879431205576;12197.390130493262;11530.481128349076;12212.57255996036;12481.313527756061;12540.435680394587;12614.243145411305 04:51:06 INFO - PROCESS | 14849 | __end_tp_report 04:51:06 INFO - PROCESS | 14849 | __start_cc_report 04:51:06 INFO - PROCESS | 14849 | _x_x_mozilla_cycle_collect,857 04:51:06 INFO - PROCESS | 14849 | __end_cc_report 04:51:06 INFO - PROCESS | 14849 | __startTimestamp1467114666691__endTimestamp 04:51:06 INFO - PROCESS | 14849 | 04:51:06 INFO - PROCESS | 14849 | ------- Summary: start ------- 04:51:06 INFO - PROCESS | 14849 | Number of tests: 6 04:51:06 INFO - PROCESS | 14849 | 04:51:06 INFO - PROCESS | 14849 | [#0] dojo.html Cycles:165 Average:5033.88 Median:5182.04 stddev:506.15 (9.8%) stddev-sans-first:487.19 04:51:06 INFO - PROCESS | 14849 | Values: 3215.7 3231.6 3250.1 3260.1 3280.1 5023.9 5111.6 5122.4 5125.5 5145.0 4990.9 5004.7 5008.9 5013.7 5038.6 4511.7 4550.7 4603.7 4608.6 4619.2 4537.0 4591.5 4637.8 4640.2 4643.2 4721.3 4728.1 4743.4 4750.5 4773.9 4512.7 4697.8 4715.3 4735.8 4780.2 4390.4 4639.7 4655.6 4659.6 4703.5 5000.6 5049.9 5049.9 5056.0 5056.5 5191.8 5490.1 5497.6 5501.7 5502.9 5296.6 5329.1 5333.9 5374.7 5400.5 5067.9 5081.7 5082.4 5085.9 5087.6 5258.2 5389.3 5454.8 5477.9 5482.9 5270.4 5329.9 5336.8 5359.0 5361.7 5381.6 5384.8 5402.5 5406.0 5413.7 5101.5 5320.6 5352.5 5362.0 5362.4 5401.5 5421.9 5424.9 5425.0 5428.0 4233.5 4248.3 4259.2 4272.3 4276.7 3752.0 3785.0 3802.5 3825.5 3871.1 5110.8 5133.5 5139.0 5141.7 5162.5 5370.5 5373.9 5378.7 5382.5 5409.2 4944.6 5115.5 5148.4 5150.0 5195.1 4695.9 4724.0 4724.3 4731.8 4745.8 5463.8 5631.6 5635.8 5646.4 5656.5 5325.4 5350.8 5360.1 5385.4 5412.5 5598.6 5604.2 5605.1 5614.2 5618.7 5155.8 5272.6 5327.6 5338.3 5364.1 5332.0 5404.3 5410.4 5413.7 5424.4 5239.2 5255.4 5264.0 5269.2 5294.3 4953.5 5158.6 5196.0 5272.5 5278.9 5164.6 5185.4 5185.6 5189.4 5200.8 5268.5 5275.9 5296.5 5314.6 5316.1 5018.2 5156.3 5174.3 5182.0 5203.4 04:51:06 INFO - PROCESS | 14849 | 04:51:06 INFO - PROCESS | 14849 | [#1] ext.html Cycles:180 Average:63593.87 Median:37840.81 stddev:126275.75 (333.7%) stddev-sans-first:126541.39 04:51:06 INFO - PROCESS | 14849 | Values: 590.1 629.2 640.1 655.4 658.9 32894.8 35637.8 35687.6 35967.3 36115.8 35957.0 36601.5 45555.3 47484.0 47635.8 8952.9 9066.0 9075.0 9075.5 9087.9 8965.5 9045.3 9051.5 9056.1 9058.0 8163.6 10678.5 10924.8 10931.0 11337.0 10834.6 10903.9 10904.8 10921.2 10923.1 8177.0 10287.3 10786.1 10817.5 10854.8 41186.8 45411.1 45477.8 45499.3 45534.1 3449.8 3465.4 3518.1 3522.3 3891.9 33226.0 33342.8 33841.0 33875.5 34223.7 3930.3 3957.1 3974.3 4026.1 4153.5 364030.0 364936.0 366225.0 366594.0 366935.2 67146.3 67419.7 67503.0 67606.0 67637.3 68597.6 68604.3 68922.3 68934.7 69102.3 18880.9 19407.6 19469.9 19480.9 19504.5 13429.7 13772.4 13788.8 14046.0 14582.3 18006.9 18272.0 19097.1 19999.9 20719.9 7198.2 7218.7 7347.7 7481.4 7637.7 1007.8 1047.8 1090.8 1154.8 1160.4 34040.8 34849.5 34984.5 35000.8 35349.5 1123.6 1160.6 1163.2 1202.3 1219.5 17478.7 18043.5 18117.0 18121.6 18145.6 596914.0 601264.0 605293.0 605341.0 608074.0 63721.0 63940.7 64154.7 64282.4 64516.7 1330.8 1381.5 1433.1 1444.5 1462.7 32173.0 34722.9 34914.0 35582.5 35671.1 52731.0 53154.7 53220.2 53239.2 53287.2 420364.0 423673.0 425189.0 427508.4 427648.0 24883.5 30086.4 30141.4 30733.2 31639.4 51615.7 51685.5 52208.7 52373.0 52795.5 41285.6 42754.6 42805.8 43356.0 43435.8 41706.2 41803.2 41963.3 42338.6 42768.6 42616.8 43211.0 43481.8 43931.3 44147.0 35826.0 37753.8 37927.8 38296.0 38952.2 29040.9 29065.3 29112.0 29131.9 29296.9 04:51:06 INFO - PROCESS | 14849 | 04:51:06 INFO - PROCESS | 14849 | [#2] jquery.html Cycles:180 Average:31503.60 Median:11081.99 stddev:92207.17 (832.0%) stddev-sans-first:92436.32 04:51:06 INFO - PROCESS | 14849 | Values: 428.5 430.4 432.2 434.1 441.2 18293.0 19051.2 20031.6 20128.7 20143.1 18520.4 19038.6 19249.6 19286.2 19294.8 4921.6 5266.2 5268.9 5326.2 5332.6 5207.4 5221.7 5268.5 5447.1 5449.2 5415.9 5425.3 5427.5 5449.0 5450.6 5293.4 5411.5 5943.0 5949.1 5952.9 5359.8 5378.2 5381.1 5383.0 5391.9 14354.4 18222.9 18572.8 24077.0 24135.4 2408.2 2433.2 2463.9 2532.9 2971.7 10709.0 10843.2 10980.5 11388.9 13925.3 1958.8 2013.1 2020.9 2028.0 2039.5 81780.0 83726.0 83739.0 84182.0 85003.6 9727.8 10291.9 10475.9 10476.1 10569.9 14291.9 14437.3 14449.1 14494.5 14603.4 8207.6 8383.4 8434.1 8491.4 8507.8 8416.9 8468.7 8483.9 8497.1 8502.0 4312.5 4385.0 4413.8 4434.2 4493.0 2040.9 2084.8 2088.2 2109.0 2157.5 996.9 1078.7 1095.6 1098.4 1142.4 18435.5 18948.8 19538.4 19738.4 20041.6 1035.5 1061.5 1068.6 1073.1 1082.3 10668.6 10980.0 11080.9 11142.4 11241.2 554696.0 555425.0 557284.0 561173.0 566581.0 103149.0 106554.5 106947.5 107075.0 108056.0 1045.5 1049.6 1099.4 1109.1 1118.9 14798.5 17128.6 17606.0 17683.1 17711.9 40570.0 41085.2 41134.8 42086.2 42711.1 61190.7 62033.7 62198.1 62454.4 63090.1 8287.3 8649.7 8900.5 9009.2 9032.7 9600.5 12844.4 13191.3 13441.5 13619.1 11330.6 11888.0 11927.9 11967.2 12038.5 11256.5 11499.3 11549.2 11676.6 11779.0 10879.9 11412.1 11505.7 11673.4 12496.4 9081.2 12116.1 12807.5 12971.7 13408.3 11222.4 12243.8 12252.6 12305.1 12623.3 04:51:06 INFO - PROCESS | 14849 | 04:51:06 INFO - PROCESS | 14849 | [#3] mootools.html Cycles:180 Average:6170.34 Median:2665.14 stddev:3667.80 (137.6%) stddev-sans-first:3660.36 04:51:06 INFO - PROCESS | 14849 | Values: 1372.4 1553.5 1602.1 1779.6 1869.1 8162.8 8860.3 8993.6 9006.6 9235.9 8870.1 9067.2 9075.5 9080.0 9113.5 2368.9 2388.2 2389.5 2389.7 2390.0 2366.6 2379.1 2419.6 2423.7 2427.1 2376.8 2383.3 2390.6 2423.2 2423.8 2341.3 2353.2 2372.9 2377.1 2377.6 2284.7 2317.5 2334.0 2337.0 2337.7 7695.0 8964.4 9097.4 9206.5 9211.9 5223.9 5402.6 5544.7 5550.9 5554.1 3408.0 3461.4 3520.8 3523.3 3554.8 1066.5 1097.8 1106.2 1125.5 1146.6 13319.0 13647.2 13666.2 13677.5 13679.2 4865.6 4886.3 4902.8 4959.7 4989.8 11308.5 11384.7 11385.4 11411.8 11438.7 5605.7 5612.8 5613.9 5615.2 5616.2 4954.3 5022.7 5075.5 5085.1 5148.4 3970.4 3989.1 4002.4 4060.2 4155.5 1203.5 1224.2 1239.0 1241.7 1259.2 786.9 834.2 989.5 997.8 1001.1 5483.4 5658.6 5716.8 5761.9 5788.0 430.5 441.5 446.9 451.8 464.7 4073.2 4143.1 4147.7 4192.7 4193.4 11598.7 11992.6 12067.1 12071.5 12073.9 11346.1 11865.6 11870.3 11873.0 12015.1 8787.3 8861.4 8964.6 8987.2 8989.9 6327.8 6370.0 6461.0 6480.2 6543.4 10821.8 10849.8 11099.3 11173.2 11294.0 11311.0 11422.5 11508.4 11607.9 11659.7 8138.1 8218.9 8234.6 8237.2 8507.6 9322.8 9414.2 9492.2 9509.8 9522.4 8109.4 8218.6 8219.6 8279.4 8461.6 8259.5 8363.3 8381.2 8406.0 8433.7 7806.2 7862.8 7866.5 7937.1 7949.2 5187.7 5221.1 5320.7 5355.0 5410.3 5496.3 5593.4 5606.4 5637.3 5688.0 04:51:06 INFO - PROCESS | 14849 | 04:51:06 INFO - PROCESS | 14849 | [#4] prototype.html Cycles:180 Average:4326.17 Median:4901.08 stddev:1242.76 (25.4%) stddev-sans-first:1209.71 04:51:06 INFO - PROCESS | 14849 | Values: 340.9 346.8 350.5 351.0 354.8 4912.9 4949.7 4952.7 4963.6 4967.5 4851.6 4900.0 4902.2 4902.7 4917.8 3721.6 3876.2 3950.2 3964.7 3980.6 3881.7 3895.5 3914.3 3914.5 3919.4 3892.8 3897.8 3904.8 3909.2 3910.7 3694.8 3785.5 3915.7 3935.4 3939.2 3488.4 3493.2 3499.2 3502.3 3507.7 4593.9 4731.6 4758.2 4772.1 4773.9 4347.0 4373.6 4417.9 4426.7 4454.9 5057.5 5061.6 5079.5 5084.7 5105.1 3790.5 3794.5 3800.1 3801.1 3825.2 5013.8 5258.8 5270.4 5271.2 5272.7 3797.4 3826.7 3828.5 3838.4 3847.8 3892.8 3908.7 3913.0 3927.5 3937.1 4208.9 4385.8 4395.5 4416.3 4446.6 5102.6 5114.4 5119.8 5137.1 5137.6 1330.1 1351.8 1352.1 1359.6 1361.8 843.9 887.9 888.5 891.3 895.9 4540.7 4550.5 4575.3 4583.7 4603.0 4667.9 4680.2 4726.7 4741.6 4750.8 4530.4 4861.4 4884.9 5013.7 5024.7 2749.4 2766.9 2781.7 2784.0 2784.3 5326.3 5393.8 5481.7 5482.3 5486.6 5353.5 5361.9 5362.3 5375.3 5376.3 5432.2 5441.6 5444.6 5446.2 5464.9 5064.3 5199.4 5239.6 5241.6 5258.6 5185.1 5211.1 5216.4 5222.3 5229.3 5440.5 5440.8 5457.7 5460.8 5470.8 3766.7 3875.3 3877.6 3878.8 3884.1 5258.0 5273.8 5292.9 5293.2 5315.3 5131.3 5148.7 5157.9 5161.6 5210.9 5019.9 5104.2 5134.2 5152.5 5153.1 5035.8 5048.4 5059.9 5096.2 5114.5 5198.0 5207.0 5220.8 5225.9 5230.3 4809.9 5087.9 5099.6 5119.3 5155.0 04:51:06 INFO - PROCESS | 14849 | 04:51:06 INFO - PROCESS | 14849 | [#5] yui.html Cycles:180 Average:21002.66 Median:27446.12 stddev:28703.68 (104.6%) stddev-sans-first:28744.04 04:51:06 INFO - PROCESS | 14849 | Values: 780.2 785.1 816.1 854.9 858.3 15956.8 17106.9 17758.8 18548.2 18548.7 15658.8 15959.7 16069.8 16158.2 16176.8 721.2 852.7 870.6 872.3 874.5 868.6 869.8 873.3 873.9 874.2 909.8 911.4 911.4 911.5 911.7 748.4 880.7 904.2 907.7 908.8 659.2 662.2 663.4 663.7 664.1 16348.0 16381.4 16397.3 16467.3 16477.8 14544.3 14684.9 14836.3 14920.7 15117.7 12866.8 13023.3 13050.2 13640.2 14553.3 3888.5 4132.8 4149.3 4233.8 4235.3 75437.6 82103.0 82549.0 83134.6 83324.0 12112.8 12660.9 12768.5 12879.0 12909.8 24128.6 24281.2 24290.4 24419.8 24427.5 8898.2 9017.6 9087.6 9279.9 9301.7 5084.1 5136.7 5217.9 5254.8 5446.4 3720.0 3754.7 3823.0 3824.6 3832.6 601.3 618.9 636.3 640.5 663.9 684.9 819.5 828.8 831.1 838.9 9909.2 9968.7 9988.8 10021.0 10163.9 729.9 754.5 755.8 765.1 814.8 4918.3 4940.5 5028.4 5067.5 5293.7 91086.0 93038.0 94223.5 105968.0 122499.4 90629.0 94778.5 95373.0 95559.5 96283.5 87852.6 88495.6 88800.6 89480.0 89874.6 10130.9 10299.8 10427.6 10460.9 10474.4 49951.8 50075.5 51223.0 51393.2 51815.7 67359.7 67530.0 72547.0 74213.6 77560.0 14221.7 14340.2 14399.1 14764.8 15047.0 15580.5 15801.7 16036.3 16204.3 16221.2 12781.7 12986.7 13616.2 14403.9 14569.6 14233.9 14422.9 15311.4 15449.6 16197.2 13339.5 13734.9 13856.5 13879.2 13921.7 11310.7 11633.4 12028.3 12056.9 12197.4 11530.5 12212.6 12481.3 12540.4 12614.2 04:51:06 INFO - PROCESS | 14849 | -------- Summary: end -------- 04:51:06 INFO - PROCESS | 14849 | 04:51:07 INFO - TEST-INFO | 14849: exit 0 04:51:07 INFO - TEST-OK | dromaeo_css | took 1111809ms 04:51:07 INFO - TEST-START | kraken 04:51:07 INFO - operating with platform_type : linux_ 04:51:07 INFO - Initialising browser for kraken test... 04:51:07 INFO - TEST-INFO | started process 15037 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwrkTQF/profile http://localhost:47729/getInfo.html) 04:51:11 INFO - PROCESS | 15037 | __metrics Screen width/height:1600/1200 04:51:11 INFO - PROCESS | 15037 | colorDepth:24 04:51:11 INFO - PROCESS | 15037 | Browser inner width/height: 1024/697 04:51:11 INFO - PROCESS | 15037 | __metrics 04:51:12 ERROR - PROCESS | 15037 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:51:13 INFO - TEST-INFO | 15037: exit 0 04:51:13 INFO - Browser initialized. 04:51:13 INFO - Running cycle 1/1 for kraken test... 04:51:13 INFO - TEST-INFO | started process 15125 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwrkTQF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:51:25 INFO - PROCESS | 15125 | RSS: Main: 145780736 04:51:25 INFO - PROCESS | 15125 | 04:51:27 INFO - PROCESS | 15125 | Cycle 1(1): loaded http://localhost:47729/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47729/tests/kraken/driver.html?testName=audio-beat-detection) 04:51:28 INFO - PROCESS | 15125 | RSS: Main: 195616768 04:51:28 INFO - PROCESS | 15125 | 04:51:31 INFO - PROCESS | 15125 | Cycle 1(1): loaded http://localhost:47729/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47729/tests/kraken/driver.html?testName=audio-dft) 04:51:31 INFO - PROCESS | 15125 | RSS: Main: 192413696 04:51:31 INFO - PROCESS | 15125 | 04:51:34 INFO - PROCESS | 15125 | Cycle 1(1): loaded http://localhost:47729/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47729/tests/kraken/driver.html?testName=audio-fft) 04:51:35 INFO - PROCESS | 15125 | RSS: Main: 279973888 04:51:35 INFO - PROCESS | 15125 | 04:51:37 INFO - PROCESS | 15125 | Cycle 1(1): loaded http://localhost:47729/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47729/tests/kraken/driver.html?testName=audio-oscillator) 04:51:37 INFO - PROCESS | 15125 | RSS: Main: 188391424 04:51:37 INFO - PROCESS | 15125 | 04:51:40 INFO - PROCESS | 15125 | Cycle 1(1): loaded http://localhost:47729/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47729/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:51:40 INFO - PROCESS | 15125 | RSS: Main: 188846080 04:51:40 INFO - PROCESS | 15125 | 04:51:43 INFO - PROCESS | 15125 | Cycle 1(1): loaded http://localhost:47729/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47729/tests/kraken/driver.html?testName=imaging-darkroom) 04:51:44 INFO - PROCESS | 15125 | RSS: Main: 222715904 04:51:44 INFO - PROCESS | 15125 | 04:51:47 INFO - PROCESS | 15125 | Cycle 1(1): loaded http://localhost:47729/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47729/tests/kraken/driver.html?testName=imaging-desaturate) 04:51:48 INFO - PROCESS | 15125 | RSS: Main: 223277056 04:51:48 INFO - PROCESS | 15125 | 04:51:51 INFO - PROCESS | 15125 | Cycle 1(1): loaded http://localhost:47729/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47729/tests/kraken/driver.html?testName=json-parse-financial) 04:51:51 INFO - PROCESS | 15125 | RSS: Main: 223043584 04:51:51 INFO - PROCESS | 15125 | 04:51:53 INFO - PROCESS | 15125 | Cycle 1(1): loaded http://localhost:47729/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47729/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:51:53 INFO - PROCESS | 15125 | RSS: Main: 201633792 04:51:53 INFO - PROCESS | 15125 | 04:51:55 INFO - PROCESS | 15125 | Cycle 1(1): loaded http://localhost:47729/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47729/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:51:56 INFO - PROCESS | 15125 | RSS: Main: 202645504 04:51:56 INFO - PROCESS | 15125 | 04:51:58 INFO - PROCESS | 15125 | Cycle 1(1): loaded http://localhost:47729/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47729/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:51:58 INFO - PROCESS | 15125 | RSS: Main: 208244736 04:51:58 INFO - PROCESS | 15125 | 04:52:01 INFO - PROCESS | 15125 | Cycle 1(1): loaded http://localhost:47729/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47729/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:52:02 INFO - PROCESS | 15125 | RSS: Main: 214380544 04:52:02 INFO - PROCESS | 15125 | 04:52:04 INFO - PROCESS | 15125 | Cycle 1(1): loaded http://localhost:47729/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47729/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:52:05 INFO - PROCESS | 15125 | RSS: Main: 211783680 04:52:05 INFO - PROCESS | 15125 | 04:52:07 INFO - PROCESS | 15125 | Cycle 1(1): loaded http://localhost:47729/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47729/tests/kraken/driver.html?testName=ai-astar) 04:52:07 INFO - PROCESS | 15125 | RSS: Main: 254767104 04:52:07 INFO - PROCESS | 15125 | 04:52:07 INFO - PROCESS | 15125 | __start_tp_report 04:52:07 INFO - PROCESS | 15125 | _x_x_mozilla_page_load 04:52:07 INFO - PROCESS | 15125 | _x_x_mozilla_page_load_details 04:52:07 INFO - PROCESS | 15125 | |i|pagename|runs| 04:52:07 INFO - PROCESS | 15125 | |0;ai-astar;109;101;109;111;110;110;110;108;110;109 04:52:07 INFO - PROCESS | 15125 | |1;audio-beat-detection;169;130;132;177;128;124;154;124;191;123 04:52:07 INFO - PROCESS | 15125 | |2;audio-dft;163;162;161;161;161;159;161;160;159;160 04:52:07 INFO - PROCESS | 15125 | |3;audio-fft;75;76;75;111;76;74;74;73;97;75 04:52:07 INFO - PROCESS | 15125 | |4;audio-oscillator;86;84;113;86;85;85;119;87;86;127 04:52:07 INFO - PROCESS | 15125 | |5;imaging-gaussian-blur;117;117;116;117;118;116;117;117;116;117 04:52:07 INFO - PROCESS | 15125 | |6;imaging-darkroom;146;147;145;146;146;146;146;146;147;146 04:52:07 INFO - PROCESS | 15125 | |7;imaging-desaturate;96;95;95;96;95;95;95;95;95;95 04:52:07 INFO - PROCESS | 15125 | |8;json-parse-financial;56;54;54;56;55;56;58;57;58;57 04:52:07 INFO - PROCESS | 15125 | |9;json-stringify-tinderbox;58;59;58;58;58;58;60;58;58;58 04:52:07 INFO - PROCESS | 15125 | |10;stanford-crypto-aes;77;78;78;76;79;79;78;78;120;81 04:52:07 INFO - PROCESS | 15125 | |11;stanford-crypto-ccm;130;120;123;126;145;118;128;126;141;121 04:52:07 INFO - PROCESS | 15125 | |12;stanford-crypto-pbkdf2;161;159;155;161;154;156;153;153;156;158 04:52:07 INFO - PROCESS | 15125 | |13;stanford-crypto-sha256-iterative;61;61;62;63;60;61;62;61;60;60 04:52:07 INFO - PROCESS | 15125 | __end_tp_report 04:52:07 INFO - PROCESS | 15125 | __start_cc_report 04:52:07 INFO - PROCESS | 15125 | _x_x_mozilla_cycle_collect,1597 04:52:07 INFO - PROCESS | 15125 | __end_cc_report 04:52:07 INFO - PROCESS | 15125 | __startTimestamp1467114727358__endTimestamp 04:52:07 INFO - PROCESS | 15125 | 04:52:07 INFO - PROCESS | 15125 | ------- Summary: start ------- 04:52:07 INFO - PROCESS | 15125 | Number of tests: 14 04:52:07 INFO - PROCESS | 15125 | 04:52:07 INFO - PROCESS | 15125 | [#0] ai-astar Cycles:10 Average:108.70 Median:110.00 stddev:2.83 (2.6%) stddev-sans-first:3.00 04:52:07 INFO - PROCESS | 15125 | Values: 109.0 101.0 109.0 111.0 110.0 110.0 110.0 108.0 110.0 109.0 04:52:07 INFO - PROCESS | 15125 | 04:52:07 INFO - PROCESS | 15125 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:143.00 stddev:25.49 (17.8%) stddev-sans-first:25.53 04:52:07 INFO - PROCESS | 15125 | Values: 169.0 130.0 132.0 177.0 128.0 124.0 154.0 124.0 191.0 123.0 04:52:07 INFO - PROCESS | 15125 | 04:52:07 INFO - PROCESS | 15125 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.25 (0.8%) stddev-sans-first:1.01 04:52:07 INFO - PROCESS | 15125 | Values: 163.0 162.0 161.0 161.0 161.0 159.0 161.0 160.0 159.0 160.0 04:52:07 INFO - PROCESS | 15125 | 04:52:07 INFO - PROCESS | 15125 | [#3] audio-fft Cycles:10 Average:80.60 Median:75.00 stddev:12.80 (17.1%) stddev-sans-first:13.41 04:52:07 INFO - PROCESS | 15125 | Values: 75.0 76.0 75.0 111.0 76.0 74.0 74.0 73.0 97.0 75.0 04:52:07 INFO - PROCESS | 15125 | 04:52:07 INFO - PROCESS | 15125 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:85.50 stddev:16.82 (19.7%) stddev-sans-first:17.46 04:52:07 INFO - PROCESS | 15125 | Values: 86.0 84.0 113.0 86.0 85.0 85.0 119.0 87.0 86.0 127.0 04:52:07 INFO - PROCESS | 15125 | 04:52:07 INFO - PROCESS | 15125 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 04:52:07 INFO - PROCESS | 15125 | Values: 117.0 117.0 116.0 117.0 118.0 116.0 117.0 117.0 116.0 117.0 04:52:07 INFO - PROCESS | 15125 | 04:52:07 INFO - PROCESS | 15125 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 04:52:07 INFO - PROCESS | 15125 | Values: 146.0 147.0 145.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 04:52:07 INFO - PROCESS | 15125 | 04:52:07 INFO - PROCESS | 15125 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 04:52:07 INFO - PROCESS | 15125 | Values: 96.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 04:52:07 INFO - PROCESS | 15125 | 04:52:07 INFO - PROCESS | 15125 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.50 stddev:1.45 (2.6%) stddev-sans-first:1.54 04:52:07 INFO - PROCESS | 15125 | Values: 56.0 54.0 54.0 56.0 55.0 56.0 58.0 57.0 58.0 57.0 04:52:07 INFO - PROCESS | 15125 | 04:52:07 INFO - PROCESS | 15125 | [#9] json-stringify-tinderbox Cycles:10 Average:58.30 Median:58.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 04:52:07 INFO - PROCESS | 15125 | Values: 58.0 59.0 58.0 58.0 58.0 58.0 60.0 58.0 58.0 58.0 04:52:07 INFO - PROCESS | 15125 | 04:52:07 INFO - PROCESS | 15125 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:78.00 stddev:13.28 (17.0%) stddev-sans-first:13.94 04:52:07 INFO - PROCESS | 15125 | Values: 77.0 78.0 78.0 76.0 79.0 79.0 78.0 78.0 120.0 81.0 04:52:07 INFO - PROCESS | 15125 | 04:52:07 INFO - PROCESS | 15125 | [#11] stanford-crypto-ccm Cycles:10 Average:127.80 Median:127.00 stddev:8.87 (7.0%) stddev-sans-first:9.37 04:52:07 INFO - PROCESS | 15125 | Values: 130.0 120.0 123.0 126.0 145.0 118.0 128.0 126.0 141.0 121.0 04:52:07 INFO - PROCESS | 15125 | 04:52:07 INFO - PROCESS | 15125 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.60 Median:157.00 stddev:3.03 (1.9%) stddev-sans-first:2.76 04:52:07 INFO - PROCESS | 15125 | Values: 161.0 159.0 155.0 161.0 154.0 156.0 153.0 153.0 156.0 158.0 04:52:07 INFO - PROCESS | 15125 | 04:52:07 INFO - PROCESS | 15125 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.10 Median:61.00 stddev:0.99 (1.6%) stddev-sans-first:1.05 04:52:07 INFO - PROCESS | 15125 | Values: 61.0 61.0 62.0 63.0 60.0 61.0 62.0 61.0 60.0 60.0 04:52:07 INFO - PROCESS | 15125 | -------- Summary: end -------- 04:52:07 INFO - PROCESS | 15125 | 04:52:08 INFO - TEST-INFO | 15125: exit 0 04:52:08 INFO - TEST-OK | kraken | took 60905ms 04:52:08 INFO - SUITE-END | took 1172s 04:52:08 INFO - Completed test suite (00:19:32) 04:52:08 INFO - javascript benchmark 04:52:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3215.678432156783, 3231.5960504936884, 3250.138713240991, 3260.0545841705894, 3280.0979730574104, 5023.874403139924, 5111.56551693106, 5122.436531981479, 5125.513076257755, 5144.9742751286285, 4990.925136122961, 5004.749762511878, 5008.949910500894, 5013.724245166523, 5038.571721403685, 4511.661625378093, 4550.726956382611, 4603.677742558022, 4608.5852273295395, 4619.168549661076, 4536.9546304537025, 4591.47198072221, 4637.814487420499, 4640.2343613303765, 4643.187442197602, 4721.3390125382475, 4728.1252968201, 4743.35964644772, 4750.453697824742, 4773.880652983686, 4512.729236245803, 4697.765111744399, 4715.316279139505, 4735.81056757731, 4780.187368147406, 4390.429244198266, 4639.721616702975, 4655.627549796008, 4659.603933665642, 4703.529647035269, 5000.649954503187, 5049.949500504985, 5049.949500505021, 5056.039352523009, 5056.519630635084, 5191.766370513336, 5490.066688662937, 5497.615166938316, 5501.669899806025, 5502.9174562381595, 5296.629235953485, 5329.094054010828, 5333.866653333659, 5374.731263436813, 5400.459954004607, 5067.949320506785, 5081.74591270435, 5082.390113186404, 5085.872853178663, 5087.643864929457, 5258.237555554423, 5389.272448219519, 5454.7818087276855, 5477.863053423696, 5482.862928426821, 5270.446603106695, 5329.934013197376, 5336.799220175507, 5358.97320513395, 5361.678299302054, 5381.596380271495, 5384.811531596375, 5402.540784033323, 5406.0, 5413.729313534308, 5101.489851014943, 5320.627556071116, 5352.518273355417, 5361.973190134025, 5362.383325917492, 5401.540869026177, 5421.891562168814, 5424.945750542523, 5424.972875135599, 5428.0, 4233.534311225762, 4248.299030659969, 4259.23333799919, 4272.273713468718, 4276.700630955866, 3752.0432289765936, 3785.0, 3802.4676545283683, 3825.4835597194024, 3871.05159235989, 5110.8466745997675, 5133.512316329943, 5139.023585518739, 5141.742912854343, 5162.5095615916425, 5370.489803468664, 5373.892522149535, 5378.677279363251, 5382.461753824587, 5409.188621706776, 4944.629152813553, 5115.462876397999, 5148.407933087743, 5150.0472412603785, 5195.064888320063, 4695.906081878344, 4723.95276047242, 4724.314974328703, 4731.810727570927, 4745.83389581363, 5463.808766693147, 5631.577631677641, 5635.830925072254, 5646.435356464321, 5656.490915817596, 5325.440828713007, 5350.759215835219, 5360.115580929103, 5385.38068122171, 5412.539934105645, 5598.608097433141, 5604.187392828098, 5605.075162598288, 5614.214010038516, 5618.747156378055, 5155.819546315861, 5272.604554658493, 5327.600429967845, 5338.3060202173465, 5364.114921038141, 5331.973340133274, 5404.297441332602, 5410.3507579090765, 5413.675179489243, 5424.376196737426, 5239.161734122522, 5255.421903590525, 5264.0, 5269.1832765921345, 5294.2852714883, 4953.455119936876, 5158.561522270649, 5196.038732834438, 5272.499112584298, 5278.8944221116135, 5164.586833053271, 5185.403678577012, 5185.637005409585, 5189.377274727057, 5200.765965531636, 5268.473152684701, 5275.89448211026, 5296.523312901857, 5314.601404894571, 5316.149416093561, 5018.197088465828, 5156.329677141947, 5174.301469301596, 5182.041322355376, 5203.427622961395], "value": 5004.93999101973, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.1442907783712, 629.2103410220175, 640.1326202994942, 655.4068567946009, 658.8879890418629, 32894.83552582237, 35637.82181089094, 35687.643123568756, 35967.28065438696, 36115.81942090289, 35957.0, 36601.45097823535, 45555.31667024989, 47484.0, 47635.761821190936, 8952.910470895273, 9066.0, 9075.047120052399, 9075.455472671627, 9087.863682044775, 8965.462072275652, 9045.321600879928, 9051.502167380791, 9056.094390560957, 9057.95471022644, 8163.632636531341, 10678.51946662402, 10924.781504369908, 10931.0, 11337.036351910097, 10834.566617335297, 10903.945480272549, 10904.78190436187, 10921.180911431635, 10923.126149907988, 8176.959115204386, 10287.279890407599, 10786.137109031337, 10817.459127043616, 10854.837177442345, 41186.794066029775, 45411.091778164584, 45477.77261113673, 45499.31751023737, 45534.08931821345, 3449.827508624584, 3465.4108801503803, 3518.1204698825295, 3522.330757156132, 3891.9027024324337, 33226.0, 33342.83328583366, 33841.0, 33875.491867622004, 34223.65776342255, 3930.253251882133, 3957.109650328653, 3974.284628766821, 4026.1142548639255, 4153.460050193456, 364030.0, 364936.0, 366225.0, 366594.0, 366935.16532417433, 67146.328536714, 67419.66290168518, 67503.0, 67606.0, 67637.32362676409, 68597.59908403183, 68604.31395686079, 68922.3107768926, 68934.65532672405, 69102.30897691059, 18880.905595471933, 19407.611847762964, 19469.902650486656, 19480.902595487216, 19504.51238719015, 13429.664258393423, 13772.380242888894, 13788.793168102486, 14046.0, 14582.270886455635, 18006.92149662438, 18272.0, 19097.140628671466, 19999.900000499903, 20719.8964005179, 7198.244184360671, 7218.711251549984, 7347.706091756377, 7481.438892083115, 7637.656305466267, 1007.7732510185297, 1047.7581639474201, 1090.7654854206385, 1154.7979103656826, 1160.4255893332686, 34040.82979585086, 34849.47725784115, 34984.475232871526, 35000.82499587486, 35349.46975795365, 1123.5898896902572, 1160.5589875847124, 1163.2264544078093, 1202.2846406388185, 1219.4756254810338, 17478.65042699139, 18043.458696239133, 18117.0, 18121.63756724858, 18145.637087258445, 596914.0, 601264.0, 605293.0, 605341.0, 608074.0, 63721.0, 63940.68029659822, 64154.6792266045, 64282.35717642857, 64516.67741661262, 1330.767115754739, 1381.5371850430217, 1433.125793266107, 1444.5088669852091, 1462.700146469971, 32173.0, 34722.89408983683, 34913.9525814226, 35582.46626300556, 35671.10822229465, 52731.0, 53154.73422632862, 53220.2016969738, 53239.20141197808, 53287.20069199042, 420364.0, 423673.0, 425189.0, 427508.4498309954, 427648.0, 24883.502329953662, 30086.398272034, 30141.397172056873, 30733.23166920845, 31639.367212656078, 51615.74192129015, 51685.48314516957, 52208.73895630497, 52373.0, 52795.47204527906, 41285.58714412817, 42754.57245427506, 42805.78597106995, 43356.0, 43435.78282108569, 41706.165876682906, 41803.16393672171, 41963.29847630669, 42338.5766142347, 42768.57231427646, 42616.78691606522, 43211.0, 43481.78259108684, 43931.34102988522, 44147.0, 35826.0, 37753.81123094367, 37927.81036094802, 38296.0, 38952.220955581295, 29040.854795725885, 29065.273368165967, 29112.0, 29131.85434072816, 29296.853515732284], "value": 21213.372095805305, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.51149689354133, 430.42021338058004, 432.17023315234746, 434.0602595381, 441.1794063042742, 18292.99999999998, 19051.23795048198, 20031.59936801265, 20128.698069528968, 20143.093560789763, 18520.444386668387, 19038.61922761544, 19249.61500769984, 19286.228550857948, 19294.80705192951, 4921.557059864612, 5266.157414813631, 5268.894622107575, 5326.201069839516, 5332.626716129873, 5207.375114986207, 5221.660592061523, 5268.525832675058, 5447.12845944649, 5449.182622606601, 5415.9458405415835, 5425.294711687475, 5427.511523962842, 5449.04641687705, 5450.5639548836, 5293.417724050351, 5411.540019098381, 5943.0, 5949.137375080632, 5952.940470595282, 5359.812406565751, 5378.2470454136455, 5381.112116500773, 5382.9730851345885, 5391.919121213185, 14354.425822967069, 18222.90888545562, 18572.814271857245, 24077.0, 24135.396615084588, 2408.1812183857573, 2433.245693834917, 2463.876806159703, 2532.9240122796346, 2971.658259300165, 10709.0, 10843.240973131884, 10980.450977451095, 11388.943055284753, 13925.303734813218, 1958.7943265957012, 2013.134352228541, 2020.8888511131881, 2027.979720202794, 2039.51051747581, 81780.0, 83726.0, 83739.0, 84182.0, 85003.57498212469, 9727.756806079904, 10291.94854025725, 10475.895241047645, 10476.0571548561, 10569.947150264354, 14291.928540357232, 14437.278136093153, 14449.133052016912, 14494.492692755703, 14603.415863365346, 8207.589620518951, 8383.413161078666, 8434.072252052269, 8491.448055876348, 8507.787305317417, 8416.873746893802, 8468.661253549912, 8483.915160848435, 8497.065322814486, 8502.0, 4312.54718254585, 4385.0, 4413.823447062082, 4434.157510073141, 4493.0, 2040.9081591328427, 2084.78109798472, 2088.2064815370063, 2108.9578208435746, 2157.492989147549, 996.930214884951, 1078.6710053433778, 1095.638439315024, 1098.4397957041806, 1142.4459137318395, 18435.53911152232, 18948.81051189498, 19538.413847584594, 19738.40784776459, 20041.599168016557, 1035.4874337202982, 1061.4851796878509, 1068.636663534402, 1073.0503504398664, 1082.3397727386289, 10668.573257069631, 10980.0, 11080.944595276973, 11142.442877856074, 11241.21311508203, 554696.0, 555425.0, 557284.0, 561173.0, 566581.0, 103149.0, 106554.46722766336, 106947.46526267318, 107075.0, 108056.0, 1045.513836066233, 1049.5854137615752, 1099.4392859641641, 1109.14595761265, 1118.8937050980144, 14798.48205312852, 17128.57178570546, 17606.0, 17683.115844207994, 17711.901537481244, 40570.0, 41085.151168196906, 41134.794326028175, 42086.1582768349, 42711.14577708491, 61190.69404652948, 62033.68983155236, 62198.0670289937, 62454.37545624486, 63090.05364919622, 8287.295579875778, 8649.740507784776, 8900.465972041698, 9009.23421509179, 9032.683856065007, 9600.519974001412, 12844.357782111045, 13191.274479903697, 13441.462341506622, 13619.114757540729, 11330.60342887995, 11888.0, 11927.94036029849, 11967.222130561486, 12038.518459261531, 11256.493457794255, 11499.252548584314, 11549.191556590958, 11676.591319303783, 11779.0, 10879.891201087888, 11412.144089193178, 11505.712357190803, 11673.416329183678, 12496.437660305126, 9081.228095611947, 12116.091293153226, 12807.487700491876, 12971.740565188833, 13408.32958352098, 11222.382768947786, 12243.75512489763, 12252.571160009356, 12305.138640295094, 12623.305718185587], "value": 9448.597254553822, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1372.4098637585835, 1553.4951140879214, 1602.1028224194451, 1779.5995900922294, 1869.1215128889426, 8162.8367432651385, 8860.291176705865, 8993.640254389824, 9006.639734410615, 9235.90764092359, 8870.112988701143, 9067.183953444188, 9075.546222688856, 9080.0465951075, 9113.453192808436, 2368.9407764805887, 2388.199953015742, 2389.462370966536, 2389.7012873390827, 2389.9603672402473, 2366.5503554324623, 2379.131616959806, 2419.5644783938883, 2423.7333893271725, 2427.1262345555588, 2376.8217383696206, 2383.2969274064194, 2390.5816482115647, 2423.151896836102, 2423.7881059470265, 2341.2742049964395, 2353.235198560466, 2372.9288121356385, 2377.0967032527615, 2377.607694730376, 2284.657301404786, 2317.5249073939804, 2334.031376978552, 2336.9649455258186, 2337.6844126043106, 7695.0, 8964.372493925428, 9097.408668436598, 9206.53967301639, 9211.861822072675, 5223.895522089575, 5402.621816472849, 5544.695041772701, 5550.888982220374, 5554.1391084381585, 3407.9659203408146, 3461.4288642373976, 3520.8239588020497, 3523.348180586574, 3554.7689400188906, 1066.477426061232, 1097.7969075721016, 1106.1593189176203, 1125.5104029747085, 1146.5700362364114, 13319.0, 13647.181169129784, 13666.248356340397, 13677.521286755014, 13679.179249244977, 4865.5864251539015, 4886.315915771795, 4902.779374928136, 4959.677620954626, 4989.750512474362, 11308.491117899714, 11384.658460246206, 11385.373804440835, 11411.828822567668, 11438.656840294805, 5605.691686957257, 5612.831615051555, 5613.8596535086135, 5615.185798059259, 5616.185653080281, 4954.3311652926395, 5022.673526220784, 5075.5178258065425, 5085.084684756705, 5148.382194136728, 3970.4441378207075, 3989.082511022481, 4002.3796311571755, 4060.2285565743005, 4155.501339839238, 1203.4584437003384, 1224.1614494071412, 1238.993805030969, 1241.714405686697, 1259.2066997791333, 786.8819677048489, 834.1533343656193, 989.4656885281867, 997.8104160209537, 1001.0940099210227, 5483.369412517612, 5658.603897727202, 5716.791143308385, 5761.8559536011935, 5787.971060144672, 430.5178200415492, 441.5231549926136, 446.92849144136784, 451.7786284720463, 464.6933024204009, 4073.205724883619, 4143.129942712064, 4147.730397524211, 4192.7065105442325, 4193.412922190896, 11598.71003224926, 11992.580259690869, 12067.094967877445, 12071.517139314328, 12073.91334779874, 11346.092312614972, 11865.584704535473, 11870.34713090771, 11873.0, 12015.098867584791, 8787.253083487847, 8861.424007439624, 8964.551772411354, 8987.236084932854, 8989.910100898907, 6327.841803954938, 6369.9681501592195, 6461.0, 6480.189976252968, 6543.378379053982, 10821.837672435076, 10849.799309203647, 11099.334039957628, 11173.217874748689, 11294.0, 11311.0, 11422.543098275975, 11508.36703981289, 11607.883921160681, 11659.650210493699, 8138.064122625974, 8218.876716849132, 8234.629441675259, 8237.217464340878, 8507.617157228064, 9322.766930826783, 9414.2468602513, 9492.240620750461, 9509.762255943657, 9522.381045232038, 8109.3917956152345, 8218.589070546568, 8219.630116644885, 8279.37904657141, 8461.61922713467, 8259.504429734236, 8363.289120424588, 8381.16188381157, 8406.03330616987, 8433.704820331259, 7806.180351063056, 7862.842743145219, 7866.488678235896, 7937.126916039347, 7949.244821741925, 5187.688738675692, 5221.112410890234, 5320.707361095177, 5355.0, 5410.296661433988, 5496.285482887359, 5593.384727679871, 5606.355269144101, 5637.295338082739, 5688.0], "value": 4762.356590249771, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.9437442821933, 346.82658670664665, 350.4637904006869, 350.95437593112894, 354.80485732846927, 4912.926306105412, 4949.727764972934, 4952.653314268003, 4963.553280204781, 4967.478414766447, 4851.587615052716, 4900.0, 4902.166631672615, 4902.730349830758, 4917.778699958501, 3721.6278372162838, 3876.1666241758016, 3950.2297052074855, 3964.682825373963, 3980.621840925122, 3881.7282790204695, 3895.4935858338517, 3914.3149948758996, 3914.451976723261, 3919.4316824060493, 3892.766434013954, 3897.824597893102, 3904.804759762015, 3909.1790723948006, 3910.687145028405, 3694.833732482045, 3785.5078839750795, 3915.6671682906986, 3935.409688546741, 3939.1924655445564, 3488.372093023255, 3493.1616412061176, 3499.160201551609, 3502.2820321833965, 3507.7369197310304, 4593.862184134481, 4731.645126615517, 4758.191107511731, 4772.093302272557, 4773.925866680004, 4346.956530434687, 4373.606375426227, 4417.911641767147, 4426.7122637028815, 4454.910901781978, 5057.519535644108, 5061.620378471593, 5079.517445842639, 5084.720340381277, 5105.132127538327, 3790.507234059582, 3794.487744154559, 3800.1259710266518, 3801.1257410795397, 3825.196708691178, 5013.849584512471, 5258.789648414059, 5270.39390470097, 5271.235670827747, 5272.6836389816735, 3797.373433383461, 3826.693864490834, 3828.5260174832333, 3838.3858582626644, 3847.8076096195077, 3892.785896775648, 3908.726389152732, 3912.960870391317, 3927.489426374553, 3937.110187110146, 4208.884645568926, 4385.758783266887, 4395.472543294825, 4416.337549367557, 4446.643773649068, 5102.566281866083, 5114.43741188469, 5119.769610367543, 5137.12668846297, 5137.563307118862, 1330.1021810278023, 1351.8242628458434, 1352.114365090867, 1359.6057143428493, 1361.768499355112, 843.9156084391511, 887.8535041718173, 888.546841111038, 891.3315013739696, 895.8700988356652, 4540.704854184468, 4550.453945526558, 4575.313702944519, 4583.702059366131, 4603.0, 4667.949711314927, 4680.204365257914, 4726.740029298353, 4741.573258406691, 4750.809967601257, 4530.4110465639915, 4861.440934292602, 4884.877878053077, 5013.749312534359, 5024.748762561857, 2749.3676454415595, 2766.879413837399, 2781.7218278172427, 2783.958240626392, 2784.331760377495, 5326.280952071421, 5393.83818485446, 5481.738365672419, 5482.342118945752, 5486.61593688438, 5353.491418315254, 5361.919571206435, 5362.310872075283, 5375.3280839895015, 5376.301080859542, 5432.185172224198, 5441.646292991022, 5444.591655625764, 5446.222426562403, 5464.890702185934, 5064.290999260033, 5199.4020687621405, 5239.633225674166, 5241.633085684118, 5258.631895767413, 5185.092608793521, 5211.140161873249, 5216.426193118678, 5222.3472065991755, 5229.346331708536, 5440.510354068153, 5440.782368705208, 5457.7271136443815, 5460.836174914759, 5470.756989634231, 3766.7023115898733, 3875.2636998970106, 3877.5928527504207, 3878.8254528545717, 3884.067823722343, 5257.974694934451, 5273.841784746463, 5292.947070529245, 5293.173855020012, 5315.335583052119, 5131.281620573048, 5148.712821794551, 5157.896842063063, 5161.612879034163, 5210.869728256824, 5019.874503137451, 5104.206774674376, 5134.177367034798, 5152.458991805806, 5153.149730294459, 5035.7985680572365, 5048.368953880765, 5059.87350316245, 5096.23556466533, 5114.488551145005, 5197.9604079183555, 5207.0, 5220.817271395483, 5225.895482090261, 5230.34620672416, 4809.927851082307, 5087.87280317995, 5099.592032637454, 5119.308893299357, 5154.974225128851], "value": 3942.0287301115222, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [780.1574299756264, 785.1285073568334, 816.0819078536646, 854.8504011797936, 858.2790456016944, 15956.760648590265, 17106.91446542767, 17758.822411775895, 18548.165332560035, 18548.721769173473, 15658.765118523203, 15959.680806383894, 16069.83930160701, 16158.192090395463, 16176.75734863978, 721.2462976189868, 852.6845067325098, 870.5951732444412, 872.2803686958254, 874.4840544078992, 868.6395146014428, 869.8086420987404, 873.2708188662443, 873.8820259265013, 874.1957399192726, 909.8316811389881, 911.3666002128523, 911.4075850697067, 911.5123408976199, 911.6717981526646, 748.3638906929094, 880.7445840706188, 904.1591320072363, 907.7049958763363, 908.7955210077746, 659.156279961645, 662.2185820731535, 663.4427081251723, 663.707968493866, 664.0868805392586, 16348.0, 16381.426650067191, 16397.262123204484, 16467.258973346226, 16477.83522164787, 14544.27278636064, 14684.926575367163, 14836.25818709071, 14920.701585968329, 15117.697646047018, 12866.806997895039, 13023.28371939543, 13050.15174013686, 13640.249786261751, 14553.345099470549, 3888.51393575803, 4132.752034877917, 4149.294619914622, 4233.767142807144, 4235.343521754133, 75437.62281188613, 82103.0, 82548.9999999994, 83134.58432707858, 83324.0, 12112.757744845054, 12660.936695316464, 12768.489260429478, 12879.0, 12909.806352904714, 24128.63807042896, 24281.150159744324, 24290.392740181283, 24419.755802442105, 24427.511449770904, 8898.243649289754, 9017.63929442828, 9087.636494540144, 9279.860802087975, 9301.674441394518, 5084.084864724311, 5136.717480538607, 5217.869553261123, 5254.7635356409055, 5446.373667028263, 3719.9814000930364, 3754.718396120302, 3822.9808850956124, 3824.598417166213, 3832.5784163741964, 601.2964831147568, 618.8731310081422, 636.3445650979498, 640.5292110298926, 663.8771827211981, 684.8596037812237, 819.5287709567023, 828.8342331533718, 831.08580561382, 838.8532006898769, 9909.20726341891, 9968.651097211563, 9988.750281243027, 10021.0, 10163.898361016296, 729.901463302458, 754.4869488747704, 755.8119244786312, 765.12775436003, 814.7596459044596, 4918.311436398907, 4940.481249468826, 5028.421731500925, 5067.4932506749765, 5293.682379057192, 91086.0, 93038.0, 94223.52888235515, 105968.0, 122499.38750306191, 90629.0, 94778.52610736902, 95373.0, 95559.52220238854, 96283.51858240664, 87852.5607371959, 88495.55752221326, 88800.55599722089, 89480.0, 89874.55062724644, 10130.898691012995, 10299.794004119725, 10427.582896684047, 10460.947695261779, 10474.423906685206, 49951.75024125002, 50075.499245007086, 51223.0, 51393.229101564255, 51815.74092129666, 67359.66320168368, 67530.0, 72547.0, 74213.628931855, 77560.0, 14221.687202471277, 14340.21128837924, 14399.136051836924, 14764.778528322298, 15047.0, 15580.454684086002, 15801.68396632084, 16036.278367473258, 16204.27080781344, 16221.188940553162, 12781.679328823075, 12986.675333116747, 13616.18302901829, 14403.92798036045, 14569.635759106108, 14233.857661423668, 14422.927885360506, 15311.387544498095, 15449.613759656098, 16197.190140492692, 13339.465961414173, 13734.93132534331, 13856.515021974183, 13879.236641984384, 13921.651958700708, 11310.717232068935, 11633.360165190996, 12028.338441385808, 12056.879431205576, 12197.390130493262, 11530.481128349076, 12212.57255996036, 12481.313527756061, 12540.435680394587, 12614.243145411305], "value": 8003.618607796689, "unit": "score"}], "name": "dromaeo_css", "value": 7295.290775719249, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 101.0, 109.0, 111.0, 110.0, 110.0, 110.0, 108.0, 110.0, 109.0], "value": 108.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 130.0, 132.0, 177.0, 128.0, 124.0, 154.0, 124.0, 191.0, 123.0], "value": 145.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 161.0, 161.0, 159.0, 161.0, 160.0, 159.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 111.0, 76.0, 74.0, 74.0, 73.0, 97.0, 75.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 113.0, 86.0, 85.0, 85.0, 119.0, 87.0, 86.0, 127.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 118.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 54.0, 56.0, 55.0, 56.0, 58.0, 57.0, 58.0, 57.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 58.0, 58.0, 58.0, 60.0, 58.0, 58.0, 58.0], "value": 58.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 78.0, 76.0, 79.0, 79.0, 78.0, 78.0, 120.0, 81.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 120.0, 123.0, 126.0, 145.0, 118.0, 128.0, 126.0, 141.0, 121.0], "value": 127.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 155.0, 161.0, 154.0, 156.0, 153.0, 153.0, 156.0, 158.0], "value": 156.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 63.0, 60.0, 61.0, 62.0, 61.0, 60.0, 60.0], "value": 61.1, "unit": "score"}], "name": "kraken", "value": 1491.3999999999999, "alertThreshold": 2.0}]} 04:52:08 INFO - Return code: 0 04:52:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:52:08 ERROR - # TBPL SUCCESS # 04:52:08 INFO - Running post-action listener: _resource_record_post_action 04:52:08 INFO - ##### 04:52:08 INFO - ##### Finished run-tests step (success) 04:52:08 INFO - ##### 04:52:08 INFO - Running post-run listener: _resource_record_post_run 04:52:08 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 501555200; Read time: 0; Write time: 362572 04:52:08 INFO - TinderboxPrint: CPU usage
13.1% 04:52:08 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:52:08 INFO - TinderboxPrint: I/O write bytes / time
501,555,200 / 362,572 04:52:08 INFO - TinderboxPrint: CPU idle
8,256.7 (86.9%) 04:52:08 INFO - TinderboxPrint: CPU user
1,196.6 (12.6%) 04:52:08 INFO - TinderboxPrint: Swap in / out
0 / 0 04:52:08 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 251424768; Read time: 0; Write time: 241412 04:52:08 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 250130432; Read time: 0; Write time: 121160 04:52:09 INFO - Running post-run listener: _upload_blobber_files 04:52:09 INFO - Blob upload gear active. 04:52:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:52:09 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:52:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:52:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:52:09 INFO - (blobuploader) - INFO - Open directory for files ... 04:52:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:52:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:52:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:10 INFO - (blobuploader) - INFO - Done attempting. 04:52:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:52:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:52:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:15 INFO - (blobuploader) - INFO - Done attempting. 04:52:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:52:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:52:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:16 INFO - (blobuploader) - INFO - Done attempting. 04:52:16 INFO - (blobuploader) - INFO - Iteration through files over. 04:52:16 INFO - Return code: 0 04:52:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:52:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:52:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6b44ee91e996edf4a361a687e0efcbfa793c4d51c00d38a95a091acca4de56c41d82d86ad3d2265bc62127c2e75a7cf35a0a37e997b82426992481a0e23930d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6708881a6d4a7c72c9e83afeba5da6456b142467b41ab0ba0d6e68a20a416222266629b0f64780f4b1ec45900b616c346356a85d16ec32aa8fe75588dfe7c463", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bec9edce5ca583b067805d5c057355afa02dd5573d16e252c756c94f728b478d7f34495991c146ed6f2dc3281e3a251d05efb0a7615fee31d16675321d2dc6c6"} 04:52:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:52:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:52:16 INFO - Contents: 04:52:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6b44ee91e996edf4a361a687e0efcbfa793c4d51c00d38a95a091acca4de56c41d82d86ad3d2265bc62127c2e75a7cf35a0a37e997b82426992481a0e23930d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6708881a6d4a7c72c9e83afeba5da6456b142467b41ab0ba0d6e68a20a416222266629b0f64780f4b1ec45900b616c346356a85d16ec32aa8fe75588dfe7c463", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bec9edce5ca583b067805d5c057355afa02dd5573d16e252c756c94f728b478d7f34495991c146ed6f2dc3281e3a251d05efb0a7615fee31d16675321d2dc6c6"} 04:52:16 INFO - Running post-run listener: copy_logs_to_upload_dir 04:52:16 INFO - Copying logs to upload dir... 04:52:16 INFO - mkdir: /builds/slave/test/build/upload/logs 04:52:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.879354 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-28 04:52:15.939887) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 04:52:15.943469) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1467113499.862650-567041491 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/6b44ee91e996edf4a361a687e0efcbfa793c4d51c00d38a95a091acca4de56c41d82d86ad3d2265bc62127c2e75a7cf35a0a37e997b82426992481a0e23930d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6708881a6d4a7c72c9e83afeba5da6456b142467b41ab0ba0d6e68a20a416222266629b0f64780f4b1ec45900b616c346356a85d16ec32aa8fe75588dfe7c463", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bec9edce5ca583b067805d5c057355afa02dd5573d16e252c756c94f728b478d7f34495991c146ed6f2dc3281e3a251d05efb0a7615fee31d16675321d2dc6c6"} build_url:https://queue.taskcluster.net/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011180 build_url: 'https://queue.taskcluster.net/v1/task/VFVviIdwSaeJUZHf1nglkw/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/6b44ee91e996edf4a361a687e0efcbfa793c4d51c00d38a95a091acca4de56c41d82d86ad3d2265bc62127c2e75a7cf35a0a37e997b82426992481a0e23930d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6708881a6d4a7c72c9e83afeba5da6456b142467b41ab0ba0d6e68a20a416222266629b0f64780f4b1ec45900b616c346356a85d16ec32aa8fe75588dfe7c463", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bec9edce5ca583b067805d5c057355afa02dd5573d16e252c756c94f728b478d7f34495991c146ed6f2dc3281e3a251d05efb0a7615fee31d16675321d2dc6c6"}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 04:52:16.006023) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 04:52:16.006400) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1467113499.862650-567041491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004536 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 04:52:16.023799) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 04:52:16.024167) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 04:52:16.024481) ========= ========= Total master_lag: 0.23 =========