builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-003 starttime: 1465254990.48 results: success (0) buildid: 20160606131341 builduid: 96720e61382b4589a958e1fc18a9ab51 revision: 396b577b98e64fe95223cfce095f84fe0a67da01 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 16:16:30.481097) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 16:16:30.481513) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 16:16:30.481788) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 16:16:30.494650) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 16:16:30.494914) ========= 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=7de08804244eb36560b44971000001c3-1465254989.529956-2012116812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 16:16:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.0M=0s 2016-06-06 16:16:30 (43.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088947 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 16:16:30.595081) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 16:16:30.595382) ========= 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=7de08804244eb36560b44971000001c3-1465254989.529956-2012116812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016409 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 16:16:30.645168) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 16:16:30.645571) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 396b577b98e64fe95223cfce095f84fe0a67da01 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 396b577b98e64fe95223cfce095f84fe0a67da01 --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=7de08804244eb36560b44971000001c3-1465254989.529956-2012116812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 16:16:30,716 truncating revision to first 12 chars 2016-06-06 16:16:30,716 Setting DEBUG logging. 2016-06-06 16:16:30,716 attempt 1/10 2016-06-06 16:16:30,716 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/396b577b98e6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 16:16:31,258 unpacking tar archive at: mozilla-central-396b577b98e6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.886990 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 16:16:31.546163) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 16:16:31.546482) ========= script_repo_revision: 396b577b98e64fe95223cfce095f84fe0a67da01 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 16:16:31.546875) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 16:16:31.547139) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 16:16:31.560082) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-06-06 16:16:31.560467) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=7de08804244eb36560b44971000001c3-1465254989.529956-2012116812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:16:31 INFO - MultiFileLogger online at 20160606 16:16:31 in /builds/slave/test 16:16:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:16:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:16:31 INFO - {'append_to_log': False, 16:16:31 INFO - 'base_work_dir': '/builds/slave/test', 16:16:31 INFO - 'blob_upload_branch': 'Firefox', 16:16:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:16:31 INFO - 'branch': 'Firefox', 16:16:31 INFO - 'buildbot_json_path': 'buildprops.json', 16:16:31 INFO - 'config_files': ('talos/linux_config.py',), 16:16:31 INFO - 'default_actions': ('clobber', 16:16:31 INFO - 'read-buildbot-config', 16:16:31 INFO - 'download-and-extract', 16:16:31 INFO - 'populate-webroot', 16:16:31 INFO - 'create-virtualenv', 16:16:31 INFO - 'install', 16:16:31 INFO - 'run-tests'), 16:16:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:16:31 INFO - 'download_minidump_stackwalk': True, 16:16:31 INFO - 'download_symbols': 'ondemand', 16:16:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:16:31 INFO - 'tooltool.py': '/tools/tooltool.py', 16:16:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:16:31 INFO - '/tools/misc-python/virtualenv.py')}, 16:16:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:16:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:16:31 INFO - 'installer_path': 'installer.exe', 16:16:31 INFO - 'log_level': 'info', 16:16:31 INFO - 'log_name': 'talos', 16:16:31 INFO - 'log_to_console': True, 16:16:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:16:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:16:31 INFO - 'opt_config_files': (), 16:16:31 INFO - 'pip_index': False, 16:16:31 INFO - 'sps_profile': False, 16:16:31 INFO - 'sps_profile_interval': 0, 16:16:31 INFO - 'suite': 'dromaeojs-e10s', 16:16:31 INFO - 'system_bits': '32', 16:16:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:16:31 INFO - 'title': 'talos-linux64-ix-003', 16:16:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:16:31 INFO - 'use_talos_json': True, 16:16:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:16:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:16:31 INFO - 'work_dir': 'build'} 16:16:31 INFO - ##### 16:16:31 INFO - ##### Running clobber step. 16:16:31 INFO - ##### 16:16:31 INFO - Running pre-action listener: _resource_record_pre_action 16:16:31 INFO - Running main action method: clobber 16:16:31 INFO - rmtree: /builds/slave/test/build 16:16:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:16:32 INFO - Running post-action listener: _resource_record_post_action 16:16:32 INFO - ##### 16:16:32 INFO - ##### Finished clobber step (success) 16:16:32 INFO - ##### 16:16:32 INFO - ##### 16:16:32 INFO - ##### Running read-buildbot-config step. 16:16:32 INFO - ##### 16:16:32 INFO - Running pre-action listener: _resource_record_pre_action 16:16:32 INFO - Running main action method: read_buildbot_config 16:16:32 INFO - Using buildbot properties: 16:16:32 INFO - { 16:16:32 INFO - "project": "", 16:16:32 INFO - "product": "firefox", 16:16:32 INFO - "script_repo_revision": "production", 16:16:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:16:32 INFO - "repository": "", 16:16:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 16:16:32 INFO - "buildid": "20160606131341", 16:16:32 INFO - "stage_platform": "linux64-pgo", 16:16:32 INFO - "basedir": "/builds/slave/test", 16:16:32 INFO - "nightly_build": "True", 16:16:32 INFO - "buildnumber": 241, 16:16:32 INFO - "slavename": "talos-linux64-ix-003", 16:16:32 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:16:32 INFO - "platform": "ubuntu64_hw", 16:16:32 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 16:16:32 INFO - "branch": "mozilla-central", 16:16:32 INFO - "repo_path": "mozilla-central", 16:16:32 INFO - "revision": "396b577b98e64fe95223cfce095f84fe0a67da01", 16:16:32 INFO - "pgo_build": "True", 16:16:32 INFO - "builduid": "96720e61382b4589a958e1fc18a9ab51", 16:16:32 INFO - "slavebuilddir": "test" 16:16:32 INFO - } 16:16:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/awSUdZrnQOy6Jh_56Jjgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 16:16:32 INFO - Running post-action listener: _resource_record_post_action 16:16:32 INFO - ##### 16:16:32 INFO - ##### Finished read-buildbot-config step (success) 16:16:32 INFO - ##### 16:16:32 INFO - ##### 16:16:32 INFO - ##### Running download-and-extract step. 16:16:32 INFO - ##### 16:16:32 INFO - Running pre-action listener: _resource_record_pre_action 16:16:32 INFO - Running main action method: download_and_extract 16:16:32 INFO - mkdir: /builds/slave/test/build/tests 16:16:32 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')]} 16:16:32 INFO - https://queue.taskcluster.net/v1/task/awSUdZrnQOy6Jh_56Jjgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:16:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/awSUdZrnQOy6Jh_56Jjgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:16:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/awSUdZrnQOy6Jh_56Jjgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:16:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/awSUdZrnQOy6Jh_56Jjgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:16:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/awSUdZrnQOy6Jh_56Jjgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:16:33 INFO - Downloaded 1361 bytes. 16:16:33 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:16:33 INFO - Using the following test package requirements: 16:16:33 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:16:33 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:16:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:16:33 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:16:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:16:33 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:16:33 INFO - u'jsshell-linux-x86_64.zip'], 16:16:33 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:16:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:16:33 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:16:33 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:16:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:16:33 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:16:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:16:33 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:16:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:16:33 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:16:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:16:33 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:16:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:33 INFO - https://queue.taskcluster.net/v1/task/awSUdZrnQOy6Jh_56Jjgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:16:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/awSUdZrnQOy6Jh_56Jjgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:16:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/awSUdZrnQOy6Jh_56Jjgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:16:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/awSUdZrnQOy6Jh_56Jjgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:16:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/awSUdZrnQOy6Jh_56Jjgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:16:34 INFO - Downloaded 24442846 bytes. 16:16:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:16:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:16:36 INFO - Return code: 0 16:16:36 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:36 INFO - https://queue.taskcluster.net/v1/task/awSUdZrnQOy6Jh_56Jjgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:16:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/awSUdZrnQOy6Jh_56Jjgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:16:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/awSUdZrnQOy6Jh_56Jjgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:16:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/awSUdZrnQOy6Jh_56Jjgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:16:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/awSUdZrnQOy6Jh_56Jjgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:16:37 INFO - Downloaded 24442846 bytes. 16:16:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:16:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:16:38 INFO - Return code: 0 16:16:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:38 INFO - https://queue.taskcluster.net/v1/task/awSUdZrnQOy6Jh_56Jjgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:16:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/awSUdZrnQOy6Jh_56Jjgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:16:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/awSUdZrnQOy6Jh_56Jjgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:16:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/awSUdZrnQOy6Jh_56Jjgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:16:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/awSUdZrnQOy6Jh_56Jjgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:16:39 INFO - Downloaded 10833369 bytes. 16:16:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:16:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:16:40 INFO - Return code: 0 16:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:40 INFO - https://queue.taskcluster.net/v1/task/awSUdZrnQOy6Jh_56Jjgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:16:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/awSUdZrnQOy6Jh_56Jjgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:16:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/awSUdZrnQOy6Jh_56Jjgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:16:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/awSUdZrnQOy6Jh_56Jjgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:16:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/awSUdZrnQOy6Jh_56Jjgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:16:41 INFO - Downloaded 59173964 bytes. 16:16:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/awSUdZrnQOy6Jh_56Jjgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:16:41 INFO - mkdir: /builds/slave/test/properties 16:16:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:16:41 INFO - Writing to file /builds/slave/test/properties/build_url 16:16:41 INFO - Contents: 16:16:41 INFO - build_url:https://queue.taskcluster.net/v1/task/awSUdZrnQOy6Jh_56Jjgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:16:42 INFO - Running post-action listener: _resource_record_post_action 16:16:42 INFO - Running post-action listener: set_extra_try_arguments 16:16:42 INFO - ##### 16:16:42 INFO - ##### Finished download-and-extract step (success) 16:16:42 INFO - ##### 16:16:42 INFO - ##### 16:16:42 INFO - ##### Running populate-webroot step. 16:16:42 INFO - ##### 16:16:42 INFO - Running pre-action listener: _resource_record_pre_action 16:16:42 INFO - Running main action method: populate_webroot 16:16:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:16:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:16:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:16:42 INFO - '--tppagecycles', 16:16:42 INFO - '7'], 16:16:42 INFO - 'tests': ['tsvgm']}}, 16:16:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:16:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:16:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:16:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:16:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:16:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:16:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:42 INFO - 'talos_options': ['--disable-e10s'], 16:16:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:16:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:16:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:42 INFO - 'talos_options': ['--disable-e10s'], 16:16:42 INFO - 'tests': ['damp', 'tps']}, 16:16:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:42 INFO - 'tests': ['damp', 'tps']}, 16:16:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:16:42 INFO - 'tests': ['dromaeo_dom']}, 16:16:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:16:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:16:42 INFO - 'tests': ['a11yr', 16:16:42 INFO - 'ts_paint', 16:16:42 INFO - 'tpaint', 16:16:42 INFO - 'sessionrestore', 16:16:42 INFO - 'sessionrestore_no_auto_restore', 16:16:42 INFO - 'tabpaint']}, 16:16:42 INFO - 'other-e10s': {'tests': ['a11yr', 16:16:42 INFO - 'ts_paint', 16:16:42 INFO - 'tpaint', 16:16:42 INFO - 'sessionrestore', 16:16:42 INFO - 'sessionrestore_no_auto_restore', 16:16:42 INFO - 'tabpaint']}, 16:16:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:16:42 INFO - 'ts_paint', 16:16:42 INFO - 'tpaint', 16:16:42 INFO - 'sessionrestore', 16:16:42 INFO - 'sessionrestore_no_auto_restore', 16:16:42 INFO - 'tabpaint']}, 16:16:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:16:42 INFO - 'ts_paint', 16:16:42 INFO - 'tpaint', 16:16:42 INFO - 'sessionrestore', 16:16:42 INFO - 'sessionrestore_no_auto_restore', 16:16:42 INFO - 'tabpaint']}, 16:16:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:16:42 INFO - 'tests': ['a11yr', 16:16:42 INFO - 'ts_paint', 16:16:42 INFO - 'tpaint', 16:16:42 INFO - 'sessionrestore', 16:16:42 INFO - 'sessionrestore_no_auto_restore', 16:16:42 INFO - 'tabpaint']}, 16:16:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:16:42 INFO - 'tests': ['a11yr', 16:16:42 INFO - 'ts_paint', 16:16:42 INFO - 'tpaint', 16:16:42 INFO - 'sessionrestore', 16:16:42 INFO - 'sessionrestore_no_auto_restore', 16:16:42 INFO - 'tabpaint']}, 16:16:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:16:42 INFO - 'tests': ['tsvgx', 16:16:42 INFO - 'tsvgr_opacity', 16:16:42 INFO - 'tart', 16:16:42 INFO - 'tscrollx', 16:16:42 INFO - 'cart']}, 16:16:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:16:42 INFO - 'tsvgr_opacity', 16:16:42 INFO - 'tart', 16:16:42 INFO - 'tscrollx', 16:16:42 INFO - 'cart']}, 16:16:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:42 INFO - 'talos_options': ['--disable-e10s'], 16:16:42 INFO - 'tests': ['tp5o']}, 16:16:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:42 INFO - 'tests': ['tp5o']}, 16:16:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:42 INFO - 'talos_options': ['--disable-e10s', 16:16:42 INFO - '--xperf_path', 16:16:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:16:42 INFO - 'tests': ['tp5n']}, 16:16:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:42 INFO - 'talos_options': ['--xperf_path', 16:16:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:16:42 INFO - 'tests': ['tp5n']}}, 16:16:42 INFO - 'talos.zip': {'path': '', 16:16:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:16:42 INFO - Running post-action listener: _resource_record_post_action 16:16:42 INFO - ##### 16:16:42 INFO - ##### Finished populate-webroot step (success) 16:16:42 INFO - ##### 16:16:42 INFO - ##### 16:16:42 INFO - ##### Running create-virtualenv step. 16:16:42 INFO - ##### 16:16:42 INFO - Running pre-action listener: _resource_record_pre_action 16:16:42 INFO - Running main action method: create_virtualenv 16:16:42 INFO - Creating virtualenv /builds/slave/test/build/venv 16:16:42 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 16:16:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:16:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:16:42 INFO - Using real prefix '/usr' 16:16:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:16:42 INFO - Installing distribute.............................................................................................................................................................................................done. 16:16:44 INFO - Installing pip.................done. 16:16:44 INFO - Return code: 0 16:16:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:44 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 0x7fcec0e4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2359a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2356d00>, '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 0x2357ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2357f60>, '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': '7de08804244eb36560b44971000001c3-1465254989.529956-2012116812', '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 16:16:44 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 16:16:44 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 16:16:44 INFO - Using env: {'DISPLAY': ':0', 16:16:44 INFO - 'HOME': '/home/cltbld', 16:16:44 INFO - 'LANG': 'en_US.UTF-8', 16:16:44 INFO - 'LANGUAGE': 'en_US:en', 16:16:44 INFO - 'LOGNAME': 'cltbld', 16:16:44 INFO - 'MAIL': '/var/mail/cltbld', 16:16:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:44 INFO - 'MOZ_NO_REMOTE': '1', 16:16:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:44 INFO - 'NO_EM_RESTART': '1', 16:16:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:44 INFO - 'PWD': '/builds/slave/test', 16:16:44 INFO - 'SHELL': '/bin/bash', 16:16:44 INFO - 'SHLVL': '1', 16:16:44 INFO - 'TERM': 'linux', 16:16:44 INFO - 'TMOUT': '86400', 16:16:44 INFO - 'USER': 'cltbld', 16:16:44 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465254989.529956-2012116812', 16:16:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:44 INFO - '_': '/tools/buildbot/bin/python'} 16:16:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:45 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 16:16:45 INFO - Cleaning up... 16:16:45 INFO - Return code: 0 16:16:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:16: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')]} 16:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16: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')]} 16:16:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:45 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 0x7fcec0e4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2359a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2356d00>, '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 0x2357ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2357f60>, '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': '7de08804244eb36560b44971000001c3-1465254989.529956-2012116812', '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 16:16:45 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 16:16:45 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 16:16:45 INFO - Using env: {'DISPLAY': ':0', 16:16:45 INFO - 'HOME': '/home/cltbld', 16:16:45 INFO - 'LANG': 'en_US.UTF-8', 16:16:45 INFO - 'LANGUAGE': 'en_US:en', 16:16:45 INFO - 'LOGNAME': 'cltbld', 16:16:45 INFO - 'MAIL': '/var/mail/cltbld', 16:16:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:45 INFO - 'MOZ_NO_REMOTE': '1', 16:16:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:45 INFO - 'NO_EM_RESTART': '1', 16:16:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:45 INFO - 'PWD': '/builds/slave/test', 16:16:45 INFO - 'SHELL': '/bin/bash', 16:16:45 INFO - 'SHLVL': '1', 16:16:45 INFO - 'TERM': 'linux', 16:16:45 INFO - 'TMOUT': '86400', 16:16:45 INFO - 'USER': 'cltbld', 16:16:45 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465254989.529956-2012116812', 16:16:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:45 INFO - '_': '/tools/buildbot/bin/python'} 16:16:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:45 INFO - Downloading/unpacking psutil>=3.1.1 16:16:45 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 16:16:45 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 16:16:45 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 16:16:45 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 16:16:45 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 16:16:45 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 16:16:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:16:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:16:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:16:47 INFO - Installing collected packages: psutil 16:16:47 INFO - Running setup.py install for psutil 16:16:47 INFO - building 'psutil._psutil_linux' extension 16:16:47 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 16:16:47 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 16:16:47 INFO - building 'psutil._psutil_posix' extension 16:16:47 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 16:16:47 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 16:16:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:16:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:16:47 INFO - Successfully installed psutil 16:16:47 INFO - Cleaning up... 16:16:47 INFO - Return code: 0 16:16:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:16:47 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')]} 16:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:47 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')]} 16:16:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:47 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 0x7fcec0e4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2359a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2356d00>, '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 0x2357ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2357f60>, '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': '7de08804244eb36560b44971000001c3-1465254989.529956-2012116812', '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 16:16:47 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 16:16:47 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 16:16:47 INFO - Using env: {'DISPLAY': ':0', 16:16:47 INFO - 'HOME': '/home/cltbld', 16:16:47 INFO - 'LANG': 'en_US.UTF-8', 16:16:47 INFO - 'LANGUAGE': 'en_US:en', 16:16:47 INFO - 'LOGNAME': 'cltbld', 16:16:47 INFO - 'MAIL': '/var/mail/cltbld', 16:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:47 INFO - 'MOZ_NO_REMOTE': '1', 16:16:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:47 INFO - 'NO_EM_RESTART': '1', 16:16:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:47 INFO - 'PWD': '/builds/slave/test', 16:16:47 INFO - 'SHELL': '/bin/bash', 16:16:47 INFO - 'SHLVL': '1', 16:16:47 INFO - 'TERM': 'linux', 16:16:47 INFO - 'TMOUT': '86400', 16:16:47 INFO - 'USER': 'cltbld', 16:16:47 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465254989.529956-2012116812', 16:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:47 INFO - '_': '/tools/buildbot/bin/python'} 16:16:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:16:48 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 16:16:48 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 16:16:48 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 16:16:48 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 16:16:48 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 16:16:48 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 16:16:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:16:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:16:50 INFO - Installing collected packages: mozsystemmonitor 16:16:50 INFO - Running setup.py install for mozsystemmonitor 16:16:50 INFO - Successfully installed mozsystemmonitor 16:16:50 INFO - Cleaning up... 16:16:50 INFO - Return code: 0 16:16:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:16:50 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')]} 16:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:50 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')]} 16:16:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:50 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 0x7fcec0e4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2359a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2356d00>, '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 0x2357ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2357f60>, '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': '7de08804244eb36560b44971000001c3-1465254989.529956-2012116812', '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 16:16:50 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 16:16:50 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 16:16:50 INFO - Using env: {'DISPLAY': ':0', 16:16:50 INFO - 'HOME': '/home/cltbld', 16:16:50 INFO - 'LANG': 'en_US.UTF-8', 16:16:50 INFO - 'LANGUAGE': 'en_US:en', 16:16:50 INFO - 'LOGNAME': 'cltbld', 16:16:50 INFO - 'MAIL': '/var/mail/cltbld', 16:16:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:50 INFO - 'MOZ_NO_REMOTE': '1', 16:16:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:50 INFO - 'NO_EM_RESTART': '1', 16:16:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:50 INFO - 'PWD': '/builds/slave/test', 16:16:50 INFO - 'SHELL': '/bin/bash', 16:16:50 INFO - 'SHLVL': '1', 16:16:50 INFO - 'TERM': 'linux', 16:16:50 INFO - 'TMOUT': '86400', 16:16:50 INFO - 'USER': 'cltbld', 16:16:50 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465254989.529956-2012116812', 16:16:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:50 INFO - '_': '/tools/buildbot/bin/python'} 16:16:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:50 INFO - Downloading/unpacking jsonschema==2.5.1 16:16:50 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 16:16:50 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 16:16:50 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 16:16:50 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 16:16:50 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 16:16:50 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 16:16:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:16:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:16:52 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 16:16:52 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 16:16:52 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 16:16:52 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 16:16:52 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 16:16:52 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 16:16:52 INFO - Downloading functools32-3.2.3-2.tar.gz 16:16:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:16:52 INFO - warning: no files found matching '*.txt' 16:16:52 INFO - no previously-included directories found matching 'build' 16:16:52 INFO - no previously-included directories found matching 'dist' 16:16:52 INFO - no previously-included directories found matching '.git*' 16:16:52 INFO - Installing collected packages: jsonschema, functools32 16:16:52 INFO - Running setup.py install for functools32 16:16:52 INFO - warning: no files found matching '*.txt' 16:16:52 INFO - no previously-included directories found matching 'build' 16:16:52 INFO - no previously-included directories found matching 'dist' 16:16:52 INFO - no previously-included directories found matching '.git*' 16:16:52 INFO - Successfully installed jsonschema functools32 16:16:52 INFO - Cleaning up... 16:16:52 INFO - Return code: 0 16:16:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:52 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 0x7fcec0e4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2359a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2356d00>, '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 0x2357ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2357f60>, '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': '7de08804244eb36560b44971000001c3-1465254989.529956-2012116812', '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 16:16:52 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 16:16:52 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 16:16:52 INFO - Using env: {'DISPLAY': ':0', 16:16:52 INFO - 'HOME': '/home/cltbld', 16:16:52 INFO - 'LANG': 'en_US.UTF-8', 16:16:52 INFO - 'LANGUAGE': 'en_US:en', 16:16:52 INFO - 'LOGNAME': 'cltbld', 16:16:52 INFO - 'MAIL': '/var/mail/cltbld', 16:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:52 INFO - 'MOZ_NO_REMOTE': '1', 16:16:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:52 INFO - 'NO_EM_RESTART': '1', 16:16:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:52 INFO - 'PWD': '/builds/slave/test', 16:16:52 INFO - 'SHELL': '/bin/bash', 16:16:52 INFO - 'SHLVL': '1', 16:16:52 INFO - 'TERM': 'linux', 16:16:52 INFO - 'TMOUT': '86400', 16:16:52 INFO - 'USER': 'cltbld', 16:16:52 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465254989.529956-2012116812', 16:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:52 INFO - '_': '/tools/buildbot/bin/python'} 16:16:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:53 INFO - Downloading/unpacking blobuploader==1.2.4 16:16:53 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 16:16:53 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 16:16:53 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 16:16:53 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 16:16:53 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 16:16:53 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 16:16:54 INFO - Downloading blobuploader-1.2.4.tar.gz 16:16:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:16:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:16:54 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 16:16:54 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 16:16:54 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 16:16:54 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 16:16:54 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 16:16:54 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 16:16:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:16:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:16:55 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 16:16:55 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 16:16:55 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 16:16:55 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 16:16:55 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 16:16:55 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 16:16:55 INFO - Downloading docopt-0.6.1.tar.gz 16:16:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:16:55 INFO - Installing collected packages: blobuploader, requests, docopt 16:16:55 INFO - Running setup.py install for blobuploader 16:16:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:16:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:16:55 INFO - Running setup.py install for requests 16:16:56 INFO - Running setup.py install for docopt 16:16:56 INFO - Successfully installed blobuploader requests docopt 16:16:56 INFO - Cleaning up... 16:16:56 INFO - Return code: 0 16:16:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:16: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')]} 16:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16: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')]} 16:16:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:56 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 0x7fcec0e4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2359a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2356d00>, '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 0x2357ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2357f60>, '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': '7de08804244eb36560b44971000001c3-1465254989.529956-2012116812', '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 16:16:56 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 16:16:56 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 16:16:56 INFO - Using env: {'DISPLAY': ':0', 16:16:56 INFO - 'HOME': '/home/cltbld', 16:16:56 INFO - 'LANG': 'en_US.UTF-8', 16:16:56 INFO - 'LANGUAGE': 'en_US:en', 16:16:56 INFO - 'LOGNAME': 'cltbld', 16:16:56 INFO - 'MAIL': '/var/mail/cltbld', 16:16:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:56 INFO - 'MOZ_NO_REMOTE': '1', 16:16:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:56 INFO - 'NO_EM_RESTART': '1', 16:16:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:56 INFO - 'PWD': '/builds/slave/test', 16:16:56 INFO - 'SHELL': '/bin/bash', 16:16:56 INFO - 'SHLVL': '1', 16:16:56 INFO - 'TERM': 'linux', 16:16:56 INFO - 'TMOUT': '86400', 16:16:56 INFO - 'USER': 'cltbld', 16:16:56 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465254989.529956-2012116812', 16:16:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:56 INFO - '_': '/tools/buildbot/bin/python'} 16:16:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:16:56 INFO - Running setup.py (path:/tmp/pip-Ry0jny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:16:56 INFO - Running setup.py (path:/tmp/pip-ymfUD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:16:56 INFO - Running setup.py (path:/tmp/pip-DKhW2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:16:56 INFO - Running setup.py (path:/tmp/pip-2QfTnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:16:56 INFO - Running setup.py (path:/tmp/pip-TkcGh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:16:56 INFO - Running setup.py (path:/tmp/pip-W8GZAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:16:56 INFO - Running setup.py (path:/tmp/pip-NEhSON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:16:57 INFO - Running setup.py (path:/tmp/pip-O2njm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:16:57 INFO - Running setup.py (path:/tmp/pip-56t01D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:16:57 INFO - Running setup.py (path:/tmp/pip-X1wRDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:16:57 INFO - Running setup.py (path:/tmp/pip-IJlzam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:16:57 INFO - Running setup.py (path:/tmp/pip-XtCGpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:16:57 INFO - Running setup.py (path:/tmp/pip-QvcW1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:16:57 INFO - Running setup.py (path:/tmp/pip-IIVmcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:16:57 INFO - Running setup.py (path:/tmp/pip-P5YZ9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:16:57 INFO - Running setup.py (path:/tmp/pip-aG_Cr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:16:57 INFO - Running setup.py (path:/tmp/pip-1LKmTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:16:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:16:57 INFO - Running setup.py install for manifestparser 16:16:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:16:57 INFO - Running setup.py install for mozcrash 16:16:57 INFO - Running setup.py install for mozdebug 16:16:58 INFO - Running setup.py install for mozdevice 16:16:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:16:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:16:58 INFO - Running setup.py install for mozfile 16:16:58 INFO - Running setup.py install for mozhttpd 16:16:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:16:58 INFO - Running setup.py install for mozinfo 16:16:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:16:58 INFO - Running setup.py install for mozInstall 16:16:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:16:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:16:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:16:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:16:58 INFO - Running setup.py install for mozleak 16:16:58 INFO - Running setup.py install for mozlog 16:16:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:16:58 INFO - Running setup.py install for moznetwork 16:16:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:16:58 INFO - Running setup.py install for mozprocess 16:16:58 INFO - Running setup.py install for mozprofile 16:16:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:16:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:16:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:16:59 INFO - Running setup.py install for mozrunner 16:16:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:16:59 INFO - Running setup.py install for mozscreenshot 16:16:59 INFO - Running setup.py install for moztest 16:16:59 INFO - Running setup.py install for mozversion 16:16:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:16:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:16:59 INFO - Cleaning up... 16:16:59 INFO - Return code: 0 16:16:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:16: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')]} 16:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16: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')]} 16:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:59 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 0x7fcec0e4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2359a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2356d00>, '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 0x2357ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2357f60>, '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': '7de08804244eb36560b44971000001c3-1465254989.529956-2012116812', '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 16:16:59 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 16:16:59 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 16:16:59 INFO - Using env: {'DISPLAY': ':0', 16:16:59 INFO - 'HOME': '/home/cltbld', 16:16:59 INFO - 'LANG': 'en_US.UTF-8', 16:16:59 INFO - 'LANGUAGE': 'en_US:en', 16:16:59 INFO - 'LOGNAME': 'cltbld', 16:16:59 INFO - 'MAIL': '/var/mail/cltbld', 16:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:59 INFO - 'MOZ_NO_REMOTE': '1', 16:16:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:16:59 INFO - 'NO_EM_RESTART': '1', 16:16:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:59 INFO - 'PWD': '/builds/slave/test', 16:16:59 INFO - 'SHELL': '/bin/bash', 16:16:59 INFO - 'SHLVL': '1', 16:16:59 INFO - 'TERM': 'linux', 16:16:59 INFO - 'TMOUT': '86400', 16:16:59 INFO - 'USER': 'cltbld', 16:16:59 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465254989.529956-2012116812', 16:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:59 INFO - '_': '/tools/buildbot/bin/python'} 16:16:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:16:59 INFO - Running setup.py (path:/tmp/pip-p2b1dE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:16:59 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)) 16:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:16:59 INFO - Running setup.py (path:/tmp/pip-liUOrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:16:59 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)) 16:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:16:59 INFO - Running setup.py (path:/tmp/pip-ST5qPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:16:59 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)) 16:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:16:59 INFO - Running setup.py (path:/tmp/pip-S_1nsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:17:00 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)) 16:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:17:00 INFO - Running setup.py (path:/tmp/pip-VJr2Go-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:17:00 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)) 16:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:17:00 INFO - Running setup.py (path:/tmp/pip-QVih3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:17:00 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)) 16:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:17:00 INFO - Running setup.py (path:/tmp/pip-3acrnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:17:00 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)) 16:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:17:00 INFO - Running setup.py (path:/tmp/pip-FCbJZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:17:00 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)) 16:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:17:00 INFO - Running setup.py (path:/tmp/pip-YUPX_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:17:00 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)) 16:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:17:00 INFO - Running setup.py (path:/tmp/pip-GkPc2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:17:00 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)) 16:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:17:00 INFO - Running setup.py (path:/tmp/pip-3IwUXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:17:00 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)) 16:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:17:00 INFO - Running setup.py (path:/tmp/pip-YaQvNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:17:00 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)) 16:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:17:00 INFO - Running setup.py (path:/tmp/pip-e0j1kr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:17:00 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)) 16:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:17:00 INFO - Running setup.py (path:/tmp/pip-WZHe0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:17:00 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)) 16:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:17:00 INFO - Running setup.py (path:/tmp/pip-B39gUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:17:00 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)) 16:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:17:00 INFO - Running setup.py (path:/tmp/pip-kORP5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:17:00 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)) 16:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:17:00 INFO - Running setup.py (path:/tmp/pip-NwsPjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:17:00 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)) 16:17:00 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)) 16:17:00 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)) 16:17:00 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)) 16:17:00 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)) 16:17:00 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)) 16:17:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:02 INFO - Downloading blessings-1.6.tar.gz 16:17:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:17:02 INFO - Installing collected packages: blessings 16:17:02 INFO - Running setup.py install for blessings 16:17:03 INFO - Successfully installed blessings 16:17:03 INFO - Cleaning up... 16:17:03 INFO - Return code: 0 16:17:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:17:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:17:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:17:03 INFO - Reading from file tmpfile_stdout 16:17:03 INFO - Current package versions: 16:17:03 INFO - argparse == 1.2.1 16:17:03 INFO - blessings == 1.6 16:17:03 INFO - blobuploader == 1.2.4 16:17:03 INFO - docopt == 0.6.1 16:17:03 INFO - functools32 == 3.2.3-2 16:17:03 INFO - jsonschema == 2.5.1 16:17:03 INFO - manifestparser == 1.1 16:17:03 INFO - mozInstall == 1.12 16:17:03 INFO - mozcrash == 0.17 16:17:03 INFO - mozdebug == 0.1 16:17:03 INFO - mozdevice == 0.48 16:17:03 INFO - mozfile == 1.2 16:17:03 INFO - mozhttpd == 0.7 16:17:03 INFO - mozinfo == 0.9 16:17:03 INFO - mozleak == 0.1 16:17:03 INFO - mozlog == 3.2 16:17:03 INFO - moznetwork == 0.27 16:17:03 INFO - mozprocess == 0.22 16:17:03 INFO - mozprofile == 0.28 16:17:03 INFO - mozrunner == 6.11 16:17:03 INFO - mozscreenshot == 0.1 16:17:03 INFO - mozsystemmonitor == 0.3 16:17:03 INFO - moztest == 0.7 16:17:03 INFO - mozversion == 1.4 16:17:03 INFO - psutil == 3.1.1 16:17:03 INFO - requests == 1.2.3 16:17:03 INFO - wsgiref == 0.1.2 16:17:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:03 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 0x7fcec0e4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2359a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2356d00>, '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 0x2357ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2357f60>, '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': '7de08804244eb36560b44971000001c3-1465254989.529956-2012116812', '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 16:17:03 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 16:17:03 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 16:17:03 INFO - Using env: {'DISPLAY': ':0', 16:17:03 INFO - 'HOME': '/home/cltbld', 16:17:03 INFO - 'LANG': 'en_US.UTF-8', 16:17:03 INFO - 'LANGUAGE': 'en_US:en', 16:17:03 INFO - 'LOGNAME': 'cltbld', 16:17:03 INFO - 'MAIL': '/var/mail/cltbld', 16:17:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:03 INFO - 'MOZ_NO_REMOTE': '1', 16:17:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:03 INFO - 'NO_EM_RESTART': '1', 16:17:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:03 INFO - 'PWD': '/builds/slave/test', 16:17:03 INFO - 'SHELL': '/bin/bash', 16:17:03 INFO - 'SHLVL': '1', 16:17:03 INFO - 'TERM': 'linux', 16:17:03 INFO - 'TMOUT': '86400', 16:17:03 INFO - 'USER': 'cltbld', 16:17:03 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465254989.529956-2012116812', 16:17:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:03 INFO - '_': '/tools/buildbot/bin/python'} 16:17:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:03 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)) 16:17:03 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)) 16:17:03 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)) 16:17:03 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)) 16:17:03 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)) 16:17:03 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)) 16:17:03 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)) 16:17:03 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)) 16:17:03 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)) 16:17:03 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)) 16:17:03 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)) 16:17:03 INFO - Cleaning up... 16:17:03 INFO - Return code: 0 16:17:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcec0e4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2359a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2356d00>, '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 0x2357ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2357f60>, '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': '7de08804244eb36560b44971000001c3-1465254989.529956-2012116812', '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 16:17:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:17:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:17:03 INFO - Using env: {'DISPLAY': ':0', 16:17:03 INFO - 'HOME': '/home/cltbld', 16:17:03 INFO - 'LANG': 'en_US.UTF-8', 16:17:03 INFO - 'LANGUAGE': 'en_US:en', 16:17:03 INFO - 'LOGNAME': 'cltbld', 16:17:03 INFO - 'MAIL': '/var/mail/cltbld', 16:17:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:03 INFO - 'MOZ_NO_REMOTE': '1', 16:17:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:03 INFO - 'NO_EM_RESTART': '1', 16:17:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:03 INFO - 'PWD': '/builds/slave/test', 16:17:03 INFO - 'SHELL': '/bin/bash', 16:17:03 INFO - 'SHLVL': '1', 16:17:03 INFO - 'TERM': 'linux', 16:17:03 INFO - 'TMOUT': '86400', 16:17:03 INFO - 'USER': 'cltbld', 16:17:03 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465254989.529956-2012116812', 16:17:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:03 INFO - '_': '/tools/buildbot/bin/python'} 16:17:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:17:03 INFO - Cleaning up... 16:17:03 INFO - Return code: 0 16:17:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:17:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:17:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:17:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcec0e4af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2359a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2356d00>, '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 0x2357ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2357f60>, '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': '7de08804244eb36560b44971000001c3-1465254989.529956-2012116812', '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 16:17:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:17:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:17:03 INFO - Using env: {'DISPLAY': ':0', 16:17:03 INFO - 'HOME': '/home/cltbld', 16:17:03 INFO - 'LANG': 'en_US.UTF-8', 16:17:03 INFO - 'LANGUAGE': 'en_US:en', 16:17:03 INFO - 'LOGNAME': 'cltbld', 16:17:03 INFO - 'MAIL': '/var/mail/cltbld', 16:17:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:03 INFO - 'MOZ_NO_REMOTE': '1', 16:17:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:03 INFO - 'NO_EM_RESTART': '1', 16:17:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:03 INFO - 'PWD': '/builds/slave/test', 16:17:03 INFO - 'SHELL': '/bin/bash', 16:17:03 INFO - 'SHLVL': '1', 16:17:03 INFO - 'TERM': 'linux', 16:17:03 INFO - 'TMOUT': '86400', 16:17:03 INFO - 'USER': 'cltbld', 16:17:03 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465254989.529956-2012116812', 16:17:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:03 INFO - '_': '/tools/buildbot/bin/python'} 16:17:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:17:04 INFO - Downloading/unpacking flake8 16:17: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 16:17: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 16:17: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 16:17: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 16:17: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 16:17: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 16:17:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:17:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:17:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:17:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:17: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 16:17: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 16:17: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 16:17: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 16:17: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 16:17: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 16:17:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:17: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 16:17: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 16:17: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 16:17: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 16:17: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 16:17: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 16:17:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:17:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:17:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:17:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:17:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:17:06 INFO - no previously-included directories found matching 'docs/_build' 16:17:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:17:06 INFO - Running setup.py install for pep8 16:17:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:17:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:17:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:17:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:17:06 INFO - no previously-included directories found matching 'docs/_build' 16:17:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:17:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:17:06 INFO - Cleaning up... 16:17:06 INFO - Return code: 0 16:17:06 INFO - Running post-action listener: _resource_record_post_action 16:17:06 INFO - Running post-action listener: _start_resource_monitoring 16:17:06 INFO - Starting resource monitoring. 16:17:06 INFO - ##### 16:17:06 INFO - ##### Finished create-virtualenv step (success) 16:17:06 INFO - ##### 16:17:06 INFO - ##### 16:17:06 INFO - ##### Running install step. 16:17:06 INFO - ##### 16:17:06 INFO - Running pre-action listener: _resource_record_pre_action 16:17:06 INFO - Running main action method: install 16:17:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:17:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:17:07 INFO - Reading from file tmpfile_stdout 16:17:07 INFO - Detecting whether we're running mozinstall >=1.0... 16:17:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:17:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:17:07 INFO - Reading from file tmpfile_stdout 16:17:07 INFO - Output received: 16:17:07 INFO - Usage: mozinstall [options] installer 16:17:07 INFO - Options: 16:17:07 INFO - -h, --help show this help message and exit 16:17:07 INFO - -d DEST, --destination=DEST 16:17:07 INFO - Directory to install application into. [default: 16:17:07 INFO - "/builds/slave/test"] 16:17:07 INFO - --app=APP Application being installed. [default: firefox] 16:17:07 INFO - mkdir: /builds/slave/test/build/application 16:17:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:17:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:17:23 INFO - Reading from file tmpfile_stdout 16:17:23 INFO - Output received: 16:17:23 INFO - /builds/slave/test/build/application/firefox/firefox 16:17:23 INFO - Running post-action listener: _resource_record_post_action 16:17:24 INFO - ##### 16:17:24 INFO - ##### Finished install step (success) 16:17:24 INFO - ##### 16:17:24 INFO - ##### 16:17:24 INFO - ##### Running run-tests step. 16:17:24 INFO - ##### 16:17:24 INFO - Running pre-action listener: _resource_record_pre_action 16:17:24 INFO - Running main action method: run_tests 16:17:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:17:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:17:24 INFO - Python 2.7.3 16:17:24 INFO - Return code: 0 16:17:24 INFO - grabbing minidump binary from tooltool 16:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:24 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 0x2356d00>, '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 0x2357ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2357f60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:17:24 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 16:17:24 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 16:17:24 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 16:17:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:17:24 INFO - Return code: 0 16:17:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:17:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:17:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:17:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:17:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:17:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:17:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:17:24 INFO - Return code: 0 16:17:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/awSUdZrnQOy6Jh_56Jjgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:17:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/awSUdZrnQOy6Jh_56Jjgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:17:24 INFO - Using env: {'DISPLAY': ':0', 16:17:24 INFO - 'HOME': '/home/cltbld', 16:17:24 INFO - 'LANG': 'en_US.UTF-8', 16:17:24 INFO - 'LANGUAGE': 'en_US:en', 16:17:24 INFO - 'LOGNAME': 'cltbld', 16:17:24 INFO - 'MAIL': '/var/mail/cltbld', 16:17:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:17:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:17:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:25 INFO - 'MOZ_NO_REMOTE': '1', 16:17:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:17:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:17:25 INFO - 'NO_EM_RESTART': '1', 16:17:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:17:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:25 INFO - 'PWD': '/builds/slave/test', 16:17:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:17:25 INFO - 'SHELL': '/bin/bash', 16:17:25 INFO - 'SHLVL': '1', 16:17:25 INFO - 'TERM': 'linux', 16:17:25 INFO - 'TMOUT': '86400', 16:17:25 INFO - 'USER': 'cltbld', 16:17:25 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465254989.529956-2012116812', 16:17:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:25 INFO - '_': '/tools/buildbot/bin/python'} 16:17:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/awSUdZrnQOy6Jh_56Jjgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:17:25 INFO - mozversion application_buildid: 20160606131341 16:17:25 INFO - mozversion application_changeset: 396b577b98e64fe95223cfce095f84fe0a67da01 16:17:25 INFO - mozversion application_display_name: Nightly 16:17:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:17:25 INFO - mozversion application_name: Firefox 16:17:25 INFO - mozversion application_remotingname: firefox 16:17:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:17:25 INFO - mozversion application_vendor: Mozilla 16:17:25 INFO - mozversion application_version: 50.0a1 16:17:25 INFO - mozversion platform_buildid: 20160606131341 16:17:25 INFO - mozversion platform_changeset: 396b577b98e64fe95223cfce095f84fe0a67da01 16:17:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:17:25 INFO - mozversion platform_version: 50.0a1 16:17:25 INFO - using testdate: 1465255045 16:17:25 INFO - actual date: 1465255045 16:17:25 INFO - starting webserver on 'localhost:47460' 16:17:25 INFO - SUITE-START | Running 2 tests 16:17:25 INFO - TEST-START | dromaeo_css 16:17:25 INFO - operating with platform_type : linux_ 16:17:25 INFO - Initialising browser for dromaeo_css test... 16:17:25 INFO - TEST-INFO | started process 12797 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptOXOBG/profile http://localhost:47460/getInfo.html) 16:17:30 INFO - PROCESS | 12797 | __metrics Screen width/height:1600/1200 16:17:30 INFO - PROCESS | 12797 | colorDepth:24 16:17:30 INFO - PROCESS | 12797 | Browser inner width/height: 1024/697 16:17:30 INFO - PROCESS | 12797 | __metrics 16:17:31 ERROR - PROCESS | 12797 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 16:17:31 INFO - TEST-INFO | 12797: exit 0 16:17:31 INFO - Browser initialized. 16:17:31 INFO - Running cycle 1/1 for dromaeo_css test... 16:17:31 INFO - TEST-INFO | started process 12918 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptOXOBG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:17:43 INFO - PROCESS | 12918 | RSS: Main: 167047168 16:17:43 INFO - PROCESS | 12918 | 16:18:33 INFO - PROCESS | 12918 | 1465255113323 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] 16:20:40 INFO - PROCESS | 12918 | Cycle 1(1): loaded http://localhost:47460/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47460/tests/dromaeo/cssquery-ext.html) 16:20:41 INFO - PROCESS | 12918 | RSS: Main: 171610112 16:20:41 INFO - PROCESS | 12918 | 16:23:44 INFO - PROCESS | 12918 | Cycle 1(1): loaded http://localhost:47460/tests/dromaeo/cssquery-ext.html (next: http://localhost:47460/tests/dromaeo/cssquery-jquery.html) 16:23:44 INFO - PROCESS | 12918 | RSS: Main: 170110976 16:23:44 INFO - PROCESS | 12918 | 16:26:46 INFO - PROCESS | 12918 | Cycle 1(1): loaded http://localhost:47460/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47460/tests/dromaeo/cssquery-mootools.html) 16:26:47 INFO - PROCESS | 12918 | RSS: Main: 171593728 16:26:47 INFO - PROCESS | 12918 | 16:29:48 INFO - PROCESS | 12918 | Cycle 1(1): loaded http://localhost:47460/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47460/tests/dromaeo/cssquery-prototype.html) 16:29:49 INFO - PROCESS | 12918 | RSS: Main: 169324544 16:29:49 INFO - PROCESS | 12918 | 16:32:52 INFO - PROCESS | 12918 | Cycle 1(1): loaded http://localhost:47460/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47460/tests/dromaeo/cssquery-yui.html) 16:32:52 INFO - PROCESS | 12918 | RSS: Main: 171393024 16:32:52 INFO - PROCESS | 12918 | 16:35:55 INFO - PROCESS | 12918 | Cycle 1(1): loaded http://localhost:47460/tests/dromaeo/cssquery-yui.html (next: http://localhost:47460/tests/dromaeo/cssquery-dojo.html) 16:35:55 INFO - PROCESS | 12918 | RSS: Main: 172412928 16:35:55 INFO - PROCESS | 12918 | 16:35:55 INFO - PROCESS | 12918 | __start_tp_report 16:35:55 INFO - PROCESS | 12918 | _x_x_mozilla_page_load 16:35:55 INFO - PROCESS | 12918 | _x_x_mozilla_page_load_details 16:35:55 INFO - PROCESS | 12918 | |i|pagename|runs| 16:35:55 INFO - PROCESS | 12918 | |0;dojo.html;3137.1059248114284;3138.2938838761297;3158.1946603616084;3171.6035495563056;3181.6818318168184;5359.7588108535165;5423.267858839055;5494.093474576695;5508.91736623951;5513.917291240635;5399.298091248133;5434.375046869611;5515.062439385314;5531.197976293435;5545.667259964395;4884.902301953959;4965.205567109263;5052.166392545226;5072.492750724935;5126.30794842697;780.7250039048361;5041.344625198719;5072.188449848025;5101.362329708786;5127.564157046656;4951.306817045616;5000.249962505617;5001.224810154414;5010.774515146827;5047.066292735855;4917.655764096515;5014.924776128324;5015.699058056492;5018.422881368653;5040.521150490734;4919.409670839486;4940.975295123538;4946.703197808107;4958.578520825734;4992.126377883892;5429.185622156669;5434.402215756264;5436.036206956827;5437;5509.696966666832;5708.77164913403;5891.646501209942;5922.733476993546;5935.554833387513;5947.1971283876555;6063.242094738158;6083.969580152071;6090.025595904634;6104.2980057293535;6123;5598.524125449342;5628.831135065954;5635.21107045014;5667.064934285838;5674.092145256739;5939.821805345847;5974.581779275409;5993.190919225936;6038.788642397495;6183.412575805291;5808.186853840466;5812.44781745742;5815.447532484492;5816.970915145482;5822.155787410802;5883.235179426647;5899.351071382144;5899.557533185029;5902.468777810018;5909.261342332208;5642.294713160855;5839.240898683229;5866.032104702762;5916.852078698067;5936.792212272636;5780.508656764138;5785.88428231433;5858.2677165354335;5904.704764761831;5955.583109182402;4329.848455304049;4387.495438024668;4389.275769498061;4396.472423309224;4413.293872980308;3900.6294402031763;3914.3541315683165;3953.7825419601622;3956.1098752780968;3962.623550762673;5683.26117604717;5688.914666280009;5689.43105689436;5707.4577915098;5711.114777209539;5877.735501902424;5957.672328021914;5979.431953964367;5979.970100149559;6007.699615019232;5606;5678.772849086073;5717.113847353667;5735.4551317624755;5740.425957404226;4848.272759086095;4857.222844344888;4862.367892174066;4864.708117512961;4902.779374928136;5916.822495325147;6176.227971503562;6225.595336303126;6241.157443745127;6252;5819.039858423397;5933.080372542263;5947.672877991752;5990.910136348046;6028.246469191351;6107.786227482017;6161.568690191643;6169.938300616936;6189.783357582463;6194.752209911553;5674.319081710221;5890.52875769946;5897;5910.408959104056;5922.437368449991;5911.438413350725;5939.990201665813;5965.701714914324;5976.760929562769;6050.697465126638;5764.827055188351;5820.097884827858;5836.153757705194;5861.589688721919;5866.2373891393845;5687.232223649754;5816.389279125631;5830.679312637845;5834;5834.854128646818;5679.062954612443;5709.51469125129;5719.799807006735;5724.74238659253;5749.683767392667;5808.6224395414165;5812.534997200299;5828.562857785599;5837.066069428871;5872.471477567039;5567.498925096599;5635.774569017193;5706.743196556248;5719.599628025998;5760.308762948473 16:35:55 INFO - PROCESS | 12918 | |1;ext.html;567.6310398241143;614.1708693264093;626.7054484392334;631.6810010944472;636.5607730665837;39373.80313098434;43047;43111.35332970004;43136.56863431365;43200.783996080056;43843.78078109605;44360.334594981105;44541.331880021826;44795.3280700789;44889;8742.082081381459;8900.688475903346;8960.686375976842;8964.820703585925;8965.955170224172;8685.435446695976;8752.124787521261;8779.868301975475;8796.032436431988;8805.60374783133;8807.559622018905;8809.559522023874;8810.030896601369;8824.382293239476;8843.77890552735;8761.34289928258;8773.649054037864;8803.251723603502;8807.427517211392;8810.38327317088;8762.430442021248;8852.51311177885;8856.601452934634;8859.867101993475;8899.421537600036;41443.37834932478;41611.79194104041;41870;41894.1621167578;41931.79034104841;3450.585929688428;3462.3075384922863;3535.521705638258;3742.288965096623;4087.3664581989838;32228.516572251436;32404;32688;32756.836215819007;32802;4417.51407345195;4419.160359531678;4440.400545926291;4537.274036154233;4647.976760116211;354180;355209;355249;356207;356805;59654;60006;60045;60425.97870106477;60562.39437605656;36168.638313617055;36853.815730921175;37091.629083709355;38279.23441531154;63246.36753632497;15807.683846323009;15848.683026339639;15958;15997;16006.679866402606;12026.639200823989;12102.878971210352;12129.21160124589;12161.939190303992;12184.268943863397;19577.706334404997;19723.605527889362;19876.304329348404;19885.900570497055;19901;7154.785356439315;7216.3505284524645;7366.815829604303;7383.704651813868;7439.776806695808;1008.1128606826093;1010.5149528226492;1046.7121541575975;1057.735566108473;1149.4827327702567;32783.83608081992;32876;32999.67000330014;33154;33179.66820331814;1102.8640500284719;1121.1815374776295;1163.6101905861462;1196.4556126962211;1203.506562309449;16788.916055419646;17421.65156696884;17441.12794360277;17540.386086486913;17687.115644217996;535894;539961;542477;542649.7205083775;544785;58458;59782.70108649516;59906.70046649739;60106;60232.39767602355;1269.6127681057367;1339.0894191949567;1348.6089034180175;1388.5834249725042;1392.714493528824;31597.526037109;32135.357292853543;32640.83679581587;32720.527576259603;32843.343133136725;52398.47601523936;52498;52504.73747631237;52666.73666631642;52825.47174528359;452109;453320;453561;453733;453969;27946.860265698542;27997.860010699816;28241.57637635396;28401.57397638996;28755;48884;48927.26609100938;49532.25701614551;49821.25268120909;50278;42188.578114218464;42715.57284427116;43035.78482107569;43164;43488;40471;41548.691976391434;41936.191425722835;42088;42244.577554224066;36367;40572;41014;41300.173996520505;42027.7898610505;36962.630373695916;37331.2533749318;37469.81265093657;38386.42420363753;38460.80769596134;28137.296567585974;28639.284017899718;28846.567301490075;28867.56698649564;28904 16:35:55 INFO - PROCESS | 12918 | |2;jquery.html;392.8939186419669;393.77948348924593;398.41632009106655;398.70695039146204;419.35210100394886;13870.514531991383;18165.909170454128;18604.62790744186;19352.12915418806;19400.417987460365;18240.452786416394;18306.72539911899;18569.44291671252;19399.612007759835;19425.4172374829;5500.944990550103;5669.773209071632;5748.770049198027;5800.854978625547;5865.472107510323;5277.498637629438;5610.719464026803;5695;5705.942940570582;5739.971300143514;5636.4927156555905;5638.520725738317;5644.463775941279;5647.237622920894;5651.858703532424;5613.80351687691;5845.415458454163;5869.442402971711;5869.677167755772;5872.177895094669;5464.0711079116645;5633.746481408347;5644.858878528029;5648.068068768689;5654.491095801356;13584.184948903;14108.365123569463;14121.293935303296;14228.786568201382;14303.213323267217;2124.936251912445;2171.9565608687894;2216.789405006538;2320.5938960681815;2465.938351541226;9727.07592778685;9749.561269742879;9920.95039524805;11350.262232954832;12608.873911260862;1681.9495415137565;1731.8008429030697;1847.565920914688;1925.86518943674;1947.9902600486907;75609;79767;82964.58517707433;84251;84778.57610711906;10387.68836934893;10588.205884558689;10637.149028077734;10760.623378181883;11133.10935125188;14989.400423983137;15045.699086018438;15123.773143402857;15178.848211517743;15197.772033419507;7637.579933103732;7908.881366779503;7921.049474063149;7982.640781164861;8049.919500805034;7511.3615342696485;7537.54774713519;7556.622168891534;7719.691212351556;7728.111267204231;4526.434195725535;4559.3844830948065;4606.147862645421;4684.789184486706;4689.1559519286175;1894.3085773692503;1942.6988816733428;1952.1800843645703;1955.511122219445;1990.3630838131949;897.4166791585391;1027.209049032241;1046.4924511611862;1068.6954218047974;1096.155959910864;17078.658426831393;18217.635647287247;18907.14917828701;19168;19248.326308579133;965.2953344058876;992.925530585209;1000.6297669862198;1019.8113349030305;1055;9680.806383872283;10619;10793.892061079288;10814.62148824803;10815.080718139046;460897;467714;469146;469500;472178;54320.45679543154;71869;87791;95924.52037739767;97476;944.3767113704922;973.7127547373542;992.8758905136858;993.1905497019906;1017.2828156149749;16314.755278671068;17270.309187632352;17306;17548.736768948733;17867.821321787134;42610.78694606507;43955.34066989062;44044;44107;44937;56611.71694141503;57050.714746427664;58141.709291454965;58389.4161058401;58608.70695646494;8394.328453723565;8576.571171441277;8591.140885911358;8639.827203456021;8676.741872428589;9478.052194780466;12678.936605316914;13083.672908176992;13275.734485310433;13325.466981320638;11098.778024439627;11376.317420954769;11412.714682133013;11538.826917596074;11676.06591472697;11334.546618135182;11521.884781152416;11534.942325288655;11799.764004719686;11881.82177267359;11018.559257629606;11279.379634120201;11572.24780389272;11649.941750291195;11687.88312116868;8513.659453622033;8610.870836937576;8658.48049117055;8705.695300664447;8742.562871856255;11353.489092991;11446.65660030167;11457.713557161138;11495.252808567417;11663.183577149519 16:35:55 INFO - PROCESS | 12918 | |3;mootools.html;1361.8570050144738;1442.5023366938406;1531.463987604338;1806.7199584064474;1819.7634307540018;7740.187280335568;8273.131321211276;8328.541930193836;8871.733847984562;8880.8667869982;8387.83224335513;8527.87208191876;8672.523011234396;8689.217970382664;8798.340124490656;2316.6756654068486;2360.775726305998;2375.988120059406;2382;2385.105585405473;2324.070371851256;2341.695579574653;2368.8223383246327;2379.988100059506;2380.178838300792;2309.0648287443614;2313.375388645065;2317.3279748872806;2326.395137264315;2337.0885354711677;2275.6358982562874;2276.3171048685413;2290.473191166033;2299.5515874404414;2309.2379514760087;2282.463621049052;2316.6061769499224;2336.6378211377264;2347.14329269817;2350.6239001759636;8416.074231834493;8461.407701460901;8486.108958559324;8486.236238738482;8493.447925884859;4858.781354839005;5097;5163.199704045879;5167.0957582422925;5182.922256166161;3208.9358212835846;3212.6947939945667;3264.722498587623;3269.084656296241;3290.3583801158784;1085.7882712870994;1116.681745702479;1119.0376276402287;1149.7413082056555;1162.1690491298762;11278.661640150809;11329.830052549136;11335.603253886075;11388.943055284753;11392.772144557146;4561.794719237642;4652.767361631905;4717.386739723814;4736.218523943579;4751.809927602857;9625.278104142217;9628.807423851484;9646.421214727;9649.179819715402;9669.371490853073;5213.530782229542;5214.374275086938;5220.843374698765;5251.343582052244;5256.92114618281;4259.190753756776;4698.671093023524;4717.716936983792;4807.735574543363;4907.1903135982875;4035.757854528738;4099.733517321364;4105.774182419936;4106.835726570904;4275.615194632436;1308.8952883769275;1316.6115995781267;1318.2156616812981;1318.9274589897648;1331.0483004651721;753.5892938348613;868.2055918834322;874.6851133591902;961.3943215774158;985.3447457440865;5630.774769009194;5767.884642307215;6008.429199226067;6009.579329446984;6095.085737139465;895.1317222294364;1012.2307046644603;1014.4369874719454;1021.341234903483;1047.4657924458581;4137;4382.53983331752;4397.922508985255;4407.449068866392;4454.131444368382;10047.246456515644;10070.194384449227;10088.092071713581;10137;10156.613195898957;10074;10088.192944564416;10089.596416143419;10096.899031009743;10097.5456104474;7744.690212391554;7812.218778122256;7842.45102842807;7880.960595197102;7886.211378862183;6081.239845019372;6095.420935011344;6109.51123910095;6119.357467465852;6281.183446151971;9967.651132210338;10141.29010969225;10236.33463824849;10267.178625710074;10289.897101029193;10076.395416275047;10247.077763001365;10253.74365640865;10402.323848949794;10433.061024507831;7010.75462358815;7166.605836678824;7387.445941554298;7893.486923349964;8050.5572193529915;7926.128125906031;7938;7950.403719720928;7978.880316795136;8007.679692812222;7031.894521582282;7334;7402.259774022555;7477.214892436215;7511.887321690288;7278.927210728037;7319.963400182965;7574.659140338808;7691.961540192263;7714.845703086019;6881.41507971828;6885.449164066963;6896.344847239504;6906.37842594169;6918.342757438036;4927.359443272351;5178.43037265908;5219.112750832443;5237.319148510669;5271.4464981176425;5045.091883461012;5097.311862898461;5178.559822415137;5239.89520209586;5302.840914772563 16:35:55 INFO - PROCESS | 12918 | |4;prototype.html;336.10260604186817;336.10595815131757;339.84452860275064;343.1284537275319;343.21232770791033;5533.557315414767;5642.605017648756;5663.461971112738;5675.524363665446;5693.3452652944925;5501.339839219299;5529.889402211953;5560.805371811987;5585.636933599313;5601.3558440779325;4130.917381652373;4151.712968979611;4324.286492728696;4350.238708226064;4366.628836548881;4318.611324980751;4324.616122840692;4337.414449049385;4341.630961368288;4347.7173983690955;4310.547392523787;4320.65434765218;4329.523752387251;4331.610155086041;4345.044090300129;4007.8597249096288;4273.55127711592;4281.314989601648;4286.742795432284;4310.499910052162;3733.607971163043;3739.476473293741;3765.5104836371097;3771.7171212159196;3794.1273507093524;5401.675899446007;5437.8368648940595;5443.455654434564;5473.370562385337;5487.341519017704;4886.193778026622;4906.362172917534;4912.36139301892;4981.252812078181;5019.322391477141;5891.263592050994;5913.46778789911;5938.613990090674;5941.702914854283;5945.881082378328;4169.812358443877;4181.811818468146;4187.664986801049;4208.937620565931;4211.347241177622;5973.731182096816;6097.878042439126;6099.597092668667;6099.847503812396;6161.137440758297;4267.466566679165;4277.5617897798575;4278.165757677285;4293.914121717548;4302.204092242945;4299.441072660534;4316.2446571849805;4322.783860806947;4333.349997500401;4338.76136812472;4843.903121937541;4908.828191013369;4911.0423467424225;4930.9013819723405;4951.405831300267;5842.678652674143;5865.501432378295;5873.471387575139;5919.6744179070565;5995.910061349084;1477.933492992818;1485.8633145643591;1497.3636204613213;1497.5058230783816;1503.646643038885;927.3091546797544;945.7824700318965;949.7131386970693;951.1439704266215;957.2820384711466;5092.363454568179;5157.871053223699;5205.349331333583;5228.607854410859;5254.894902102013;5395.379531353866;5412.323459567554;5438.253681890699;5440.319960004999;5461.918071228934;4945.530174633404;5090.847274581768;5129.589632829439;5150.562202212854;5236.92144617831;2892.3492214251623;2910.2287893708185;2914.7757941664554;2960.48191566475;2964.6590642076007;5453.263809385761;5462.317210348707;5492.951411966317;5583.804566840141;5604.523615492647;5507.779688812483;5603.215549823028;5608.270924779834;5616.438356164433;5627.383266780967;5489.721765467366;5653.547716182696;5659.43405659439;5679.608495918444;5687.895478672917;5249.580033597226;5297.258383826191;5362.973185134206;5509.917351239655;5523.834284971457;5301.655392399482;5455.863603409946;5460.399356070909;5467.890642187054;5470.562355011669;5540.473655002768;5548.446434998207;5561.944380556142;5566.940232113981;5576.10782274834;3608.9819550902075;3847.96152038476;3875.554311254242;3923.372260438316;3924.9018774530864;5174.482551744946;5336.825898302523;5405.783768649368;5837.211976383134;5995.790147344822;5911.793087241926;5938.673372964356;5951.523878089656;5982.52139828804;5994.831007953581;5838.474537291664;5871.706414679164;5893.909626719071;5962.493188078888;6005.069214271794;5628.915566266591;5846.181534585076;5864.9413505864395;5879.441453061952;5891.410858914074;5945.583809133319;5988.580799344004;5994.82015539517;6011.969940150271;6025.939740602538;5609.102543593006;5833.649981001154;5861.3845546217035;5880.294364676095;5893.528517718487 16:35:55 INFO - PROCESS | 12918 | |5;yui.html;626.4236902050113;627.4353082225999;686.7914056925395;698.5180225644305;768.6195333310012;14997.5500734978;15743.527694169165;15744;15800.920995395021;15814.130222837739;14472.276386180702;14642.707145857077;14703.264836758146;14806.777898331507;14829.555113346616;822.3585603229491;823.6664151018817;829.6308142876422;830.2693629605968;830.6635812495949;806.3589446390105;806.9435139540235;808.3048578222753;808.8988876390451;814.6089876859111;846.3398549131687;852.5651917522047;855.8117214212895;856.3149480415674;857.3227150551088;842.5913431985482;848.499385362639;853.6500034985658;854.8247609240091;855.055164043732;612.3111499562991;616.014376996806;617.6541136963315;618.4959258204549;619.5105866365566;14502.854971450255;14710.411583536647;14719.411223551046;14753.557393278219;14761.33573989173;14178.14931104137;14190.929045354811;14282.785758213635;14415.207163605997;14437.35031923566;10637.73405664857;10721.012170093012;10749.677509674722;11206.15953803468;11241.775164496665;3632.963670363289;3687.649673281034;3709.5733990591157;3716.6655001050035;3747.400415933465;50627.74686126583;60496.69751651258;62455;63377.36622633761;73829.26170738277;10345.534450949724;10375.429351385746;10607.628732994463;10863.565457381774;11395.259308144945;17781;17816.198271077832;17883.910580447013;17923.28306867711;18185.63628727418;8155.877661835078;8204.548749818698;8488.575571221538;8490.872636910452;8686.782830429163;4661.86014419568;4701.929471057937;4710.222813235778;4732.266498692708;4885.8289959851945;3550.5739311282296;3626.673599376069;3629.256002519477;3636.2727454509204;3651.744377893575;627.5310667532386;630.5460068750492;639.0829160155192;645.096864389858;652.5921299188008;595.4161929268213;607.76601008612;670.483727529809;675.0043685563754;693.0505207865156;9117.81764364709;9201.585928633227;9558.235341172689;9589.520523973913;9740.805183896282;620.5780069552658;634.5336177909234;654.2835595023441;691.975780847678;693.2547511425238;4189.476315460567;4199.286121359376;4272.572742725764;4302.440682711227;4444;63958.36041639617;65950;108217;109312.4534377323;112659;59986.400135998956;63342.999999999076;64329.356706433275;72798;82399.76400354;86461;88104.5594772022;88155.55922220348;88621;89567.55216224007;9223.845896715698;9316.906830931875;9589.664361747584;9593.42439453635;9993.550290236812;50896.49103508917;52644;52961.470385297194;53620.73189634027;53746.46253537571;72749;76877;77312.2268777305;78853;79513;11621.302721836717;12292.938535307267;12671.746565068463;12720.173188742701;12901.354932253162;13629.386677599334;13673.521426750016;13917.4433022682;13942;13980.510682126076;12687.80968285458;12997.545085921947;13048.282344470765;13053.216806991612;13229.735405292033;11295;11750.70623234426;11999.100067495147;12416.068794840603;12433.06751993586;11628.883711163118;11832.940835295769;12005.939970300093;12179.878201217874;12232.449539770909;10177.592896284066;10373.170146388422;10388.532516036645;10585.417802020962;10895.455227238765;10917.890821091687;10979.231453798158;10995.198538210752;11036.337819730841;11135.888641113484 16:35:55 INFO - PROCESS | 12918 | __end_tp_report 16:35:55 INFO - PROCESS | 12918 | __start_cc_report 16:35:55 INFO - PROCESS | 12918 | _x_x_mozilla_cycle_collect,372 16:35:55 INFO - PROCESS | 12918 | __end_cc_report 16:35:55 INFO - PROCESS | 12918 | __startTimestamp1465256155697__endTimestamp 16:35:55 INFO - PROCESS | 12918 | 16:35:55 INFO - PROCESS | 12918 | ------- Summary: start ------- 16:35:55 INFO - PROCESS | 12918 | Number of tests: 6 16:35:55 INFO - PROCESS | 12918 | 16:35:55 INFO - PROCESS | 12918 | [#0] dojo.html Cycles:165 Average:5463.61 Median:5719.80 stddev:754.15 (13.2%) stddev-sans-first:734.05 16:35:55 INFO - PROCESS | 12918 | Values: 3137.1 3138.3 3158.2 3171.6 3181.7 5359.8 5423.3 5494.1 5508.9 5513.9 5399.3 5434.4 5515.1 5531.2 5545.7 4884.9 4965.2 5052.2 5072.5 5126.3 780.7 5041.3 5072.2 5101.4 5127.6 4951.3 5000.2 5001.2 5010.8 5047.1 4917.7 5014.9 5015.7 5018.4 5040.5 4919.4 4941.0 4946.7 4958.6 4992.1 5429.2 5434.4 5436.0 5437.0 5509.7 5708.8 5891.6 5922.7 5935.6 5947.2 6063.2 6084.0 6090.0 6104.3 6123.0 5598.5 5628.8 5635.2 5667.1 5674.1 5939.8 5974.6 5993.2 6038.8 6183.4 5808.2 5812.4 5815.4 5817.0 5822.2 5883.2 5899.4 5899.6 5902.5 5909.3 5642.3 5839.2 5866.0 5916.9 5936.8 5780.5 5785.9 5858.3 5904.7 5955.6 4329.8 4387.5 4389.3 4396.5 4413.3 3900.6 3914.4 3953.8 3956.1 3962.6 5683.3 5688.9 5689.4 5707.5 5711.1 5877.7 5957.7 5979.4 5980.0 6007.7 5606.0 5678.8 5717.1 5735.5 5740.4 4848.3 4857.2 4862.4 4864.7 4902.8 5916.8 6176.2 6225.6 6241.2 6252.0 5819.0 5933.1 5947.7 5990.9 6028.2 6107.8 6161.6 6169.9 6189.8 6194.8 5674.3 5890.5 5897.0 5910.4 5922.4 5911.4 5940.0 5965.7 5976.8 6050.7 5764.8 5820.1 5836.2 5861.6 5866.2 5687.2 5816.4 5830.7 5834.0 5834.9 5679.1 5709.5 5719.8 5724.7 5749.7 5808.6 5812.5 5828.6 5837.1 5872.5 5567.5 5635.8 5706.7 5719.6 5760.3 16:35:55 INFO - PROCESS | 12918 | 16:35:55 INFO - PROCESS | 12918 | [#1] ext.html Cycles:180 Average:60813.97 Median:41933.99 stddev:121037.58 (288.6%) stddev-sans-first:121292.60 16:35:55 INFO - PROCESS | 12918 | Values: 567.6 614.2 626.7 631.7 636.6 39373.8 43047.0 43111.4 43136.6 43200.8 43843.8 44360.3 44541.3 44795.3 44889.0 8742.1 8900.7 8960.7 8964.8 8966.0 8685.4 8752.1 8779.9 8796.0 8805.6 8807.6 8809.6 8810.0 8824.4 8843.8 8761.3 8773.6 8803.3 8807.4 8810.4 8762.4 8852.5 8856.6 8859.9 8899.4 41443.4 41611.8 41870.0 41894.2 41931.8 3450.6 3462.3 3535.5 3742.3 4087.4 32228.5 32404.0 32688.0 32756.8 32802.0 4417.5 4419.2 4440.4 4537.3 4648.0 354180.0 355209.0 355249.0 356207.0 356805.0 59654.0 60006.0 60045.0 60426.0 60562.4 36168.6 36853.8 37091.6 38279.2 63246.4 15807.7 15848.7 15958.0 15997.0 16006.7 12026.6 12102.9 12129.2 12161.9 12184.3 19577.7 19723.6 19876.3 19885.9 19901.0 7154.8 7216.4 7366.8 7383.7 7439.8 1008.1 1010.5 1046.7 1057.7 1149.5 32783.8 32876.0 32999.7 33154.0 33179.7 1102.9 1121.2 1163.6 1196.5 1203.5 16788.9 17421.7 17441.1 17540.4 17687.1 535894.0 539961.0 542477.0 542649.7 544785.0 58458.0 59782.7 59906.7 60106.0 60232.4 1269.6 1339.1 1348.6 1388.6 1392.7 31597.5 32135.4 32640.8 32720.5 32843.3 52398.5 52498.0 52504.7 52666.7 52825.5 452109.0 453320.0 453561.0 453733.0 453969.0 27946.9 27997.9 28241.6 28401.6 28755.0 48884.0 48927.3 49532.3 49821.3 50278.0 42188.6 42715.6 43035.8 43164.0 43488.0 40471.0 41548.7 41936.2 42088.0 42244.6 36367.0 40572.0 41014.0 41300.2 42027.8 36962.6 37331.3 37469.8 38386.4 38460.8 28137.3 28639.3 28846.6 28867.6 28904.0 16:35:55 INFO - PROCESS | 12918 | 16:35:55 INFO - PROCESS | 12918 | [#2] jquery.html Cycles:180 Average:27766.44 Median:398.56 stddev:77177.22 (19363.9%) stddev-sans-first:77366.35 16:35:55 INFO - PROCESS | 12918 | Values: 392.9 393.8 398.4 398.7 419.4 13870.5 18165.9 18604.6 19352.1 19400.4 18240.5 18306.7 18569.4 19399.6 19425.4 5500.9 5669.8 5748.8 5800.9 5865.5 5277.5 5610.7 5695.0 5705.9 5740.0 5636.5 5638.5 5644.5 5647.2 5651.9 5613.8 5845.4 5869.4 5869.7 5872.2 5464.1 5633.7 5644.9 5648.1 5654.5 13584.2 14108.4 14121.3 14228.8 14303.2 2124.9 2172.0 2216.8 2320.6 2465.9 9727.1 9749.6 9921.0 11350.3 12608.9 1681.9 1731.8 1847.6 1925.9 1948.0 75609.0 79767.0 82964.6 84251.0 84778.6 10387.7 10588.2 10637.1 10760.6 11133.1 14989.4 15045.7 15123.8 15178.8 15197.8 7637.6 7908.9 7921.0 7982.6 8049.9 7511.4 7537.5 7556.6 7719.7 7728.1 4526.4 4559.4 4606.1 4684.8 4689.2 1894.3 1942.7 1952.2 1955.5 1990.4 897.4 1027.2 1046.5 1068.7 1096.2 17078.7 18217.6 18907.1 19168.0 19248.3 965.3 992.9 1000.6 1019.8 1055.0 9680.8 10619.0 10793.9 10814.6 10815.1 460897.0 467714.0 469146.0 469500.0 472178.0 54320.5 71869.0 87791.0 95924.5 97476.0 944.4 973.7 992.9 993.2 1017.3 16314.8 17270.3 17306.0 17548.7 17867.8 42610.8 43955.3 44044.0 44107.0 44937.0 56611.7 57050.7 58141.7 58389.4 58608.7 8394.3 8576.6 8591.1 8639.8 8676.7 9478.1 12678.9 13083.7 13275.7 13325.5 11098.8 11376.3 11412.7 11538.8 11676.1 11334.5 11521.9 11534.9 11799.8 11881.8 11018.6 11279.4 11572.2 11649.9 11687.9 8513.7 8610.9 8658.5 8705.7 8742.6 11353.5 11446.7 11457.7 11495.3 11663.2 16:35:55 INFO - PROCESS | 12918 | 16:35:55 INFO - PROCESS | 12918 | [#3] mootools.html Cycles:180 Average:5655.16 Median:4779.77 stddev:3101.37 (64.9%) stddev-sans-first:3093.28 16:35:55 INFO - PROCESS | 12918 | Values: 1361.9 1442.5 1531.5 1806.7 1819.8 7740.2 8273.1 8328.5 8871.7 8880.9 8387.8 8527.9 8672.5 8689.2 8798.3 2316.7 2360.8 2376.0 2382.0 2385.1 2324.1 2341.7 2368.8 2380.0 2380.2 2309.1 2313.4 2317.3 2326.4 2337.1 2275.6 2276.3 2290.5 2299.6 2309.2 2282.5 2316.6 2336.6 2347.1 2350.6 8416.1 8461.4 8486.1 8486.2 8493.4 4858.8 5097.0 5163.2 5167.1 5182.9 3208.9 3212.7 3264.7 3269.1 3290.4 1085.8 1116.7 1119.0 1149.7 1162.2 11278.7 11329.8 11335.6 11388.9 11392.8 4561.8 4652.8 4717.4 4736.2 4751.8 9625.3 9628.8 9646.4 9649.2 9669.4 5213.5 5214.4 5220.8 5251.3 5256.9 4259.2 4698.7 4717.7 4807.7 4907.2 4035.8 4099.7 4105.8 4106.8 4275.6 1308.9 1316.6 1318.2 1318.9 1331.0 753.6 868.2 874.7 961.4 985.3 5630.8 5767.9 6008.4 6009.6 6095.1 895.1 1012.2 1014.4 1021.3 1047.5 4137.0 4382.5 4397.9 4407.4 4454.1 10047.2 10070.2 10088.1 10137.0 10156.6 10074.0 10088.2 10089.6 10096.9 10097.5 7744.7 7812.2 7842.5 7881.0 7886.2 6081.2 6095.4 6109.5 6119.4 6281.2 9967.7 10141.3 10236.3 10267.2 10289.9 10076.4 10247.1 10253.7 10402.3 10433.1 7010.8 7166.6 7387.4 7893.5 8050.6 7926.1 7938.0 7950.4 7978.9 8007.7 7031.9 7334.0 7402.3 7477.2 7511.9 7278.9 7320.0 7574.7 7692.0 7714.8 6881.4 6885.4 6896.3 6906.4 6918.3 4927.4 5178.4 5219.1 5237.3 5271.4 5045.1 5097.3 5178.6 5239.9 5302.8 16:35:55 INFO - PROCESS | 12918 | 16:35:55 INFO - PROCESS | 12918 | [#4] prototype.html Cycles:180 Average:4765.92 Median:5438.05 stddev:1394.32 (25.6%) stddev-sans-first:1358.01 16:35:55 INFO - PROCESS | 12918 | Values: 336.1 336.1 339.8 343.1 343.2 5533.6 5642.6 5663.5 5675.5 5693.3 5501.3 5529.9 5560.8 5585.6 5601.4 4130.9 4151.7 4324.3 4350.2 4366.6 4318.6 4324.6 4337.4 4341.6 4347.7 4310.5 4320.7 4329.5 4331.6 4345.0 4007.9 4273.6 4281.3 4286.7 4310.5 3733.6 3739.5 3765.5 3771.7 3794.1 5401.7 5437.8 5443.5 5473.4 5487.3 4886.2 4906.4 4912.4 4981.3 5019.3 5891.3 5913.5 5938.6 5941.7 5945.9 4169.8 4181.8 4187.7 4208.9 4211.3 5973.7 6097.9 6099.6 6099.8 6161.1 4267.5 4277.6 4278.2 4293.9 4302.2 4299.4 4316.2 4322.8 4333.3 4338.8 4843.9 4908.8 4911.0 4930.9 4951.4 5842.7 5865.5 5873.5 5919.7 5995.9 1477.9 1485.9 1497.4 1497.5 1503.6 927.3 945.8 949.7 951.1 957.3 5092.4 5157.9 5205.3 5228.6 5254.9 5395.4 5412.3 5438.3 5440.3 5461.9 4945.5 5090.8 5129.6 5150.6 5236.9 2892.3 2910.2 2914.8 2960.5 2964.7 5453.3 5462.3 5493.0 5583.8 5604.5 5507.8 5603.2 5608.3 5616.4 5627.4 5489.7 5653.5 5659.4 5679.6 5687.9 5249.6 5297.3 5363.0 5509.9 5523.8 5301.7 5455.9 5460.4 5467.9 5470.6 5540.5 5548.4 5561.9 5566.9 5576.1 3609.0 3848.0 3875.6 3923.4 3924.9 5174.5 5336.8 5405.8 5837.2 5995.8 5911.8 5938.7 5951.5 5982.5 5994.8 5838.5 5871.7 5893.9 5962.5 6005.1 5628.9 5846.2 5864.9 5879.4 5891.4 5945.6 5988.6 5994.8 6012.0 6025.9 5609.1 5833.6 5861.4 5880.3 5893.5 16:35:55 INFO - PROCESS | 12918 | 16:35:55 INFO - PROCESS | 12918 | [#5] yui.html Cycles:180 Average:18740.32 Median:4721.24 stddev:26053.79 (551.8%) stddev-sans-first:26091.38 16:35:55 INFO - PROCESS | 12918 | Values: 626.4 627.4 686.8 698.5 768.6 14997.6 15743.5 15744.0 15800.9 15814.1 14472.3 14642.7 14703.3 14806.8 14829.6 822.4 823.7 829.6 830.3 830.7 806.4 806.9 808.3 808.9 814.6 846.3 852.6 855.8 856.3 857.3 842.6 848.5 853.7 854.8 855.1 612.3 616.0 617.7 618.5 619.5 14502.9 14710.4 14719.4 14753.6 14761.3 14178.1 14190.9 14282.8 14415.2 14437.4 10637.7 10721.0 10749.7 11206.2 11241.8 3633.0 3687.6 3709.6 3716.7 3747.4 50627.7 60496.7 62455.0 63377.4 73829.3 10345.5 10375.4 10607.6 10863.6 11395.3 17781.0 17816.2 17883.9 17923.3 18185.6 8155.9 8204.5 8488.6 8490.9 8686.8 4661.9 4701.9 4710.2 4732.3 4885.8 3550.6 3626.7 3629.3 3636.3 3651.7 627.5 630.5 639.1 645.1 652.6 595.4 607.8 670.5 675.0 693.1 9117.8 9201.6 9558.2 9589.5 9740.8 620.6 634.5 654.3 692.0 693.3 4189.5 4199.3 4272.6 4302.4 4444.0 63958.4 65950.0 108217.0 109312.5 112659.0 59986.4 63343.0 64329.4 72798.0 82399.8 86461.0 88104.6 88155.6 88621.0 89567.6 9223.8 9316.9 9589.7 9593.4 9993.6 50896.5 52644.0 52961.5 53620.7 53746.5 72749.0 76877.0 77312.2 78853.0 79513.0 11621.3 12292.9 12671.7 12720.2 12901.4 13629.4 13673.5 13917.4 13942.0 13980.5 12687.8 12997.5 13048.3 13053.2 13229.7 11295.0 11750.7 11999.1 12416.1 12433.1 11628.9 11832.9 12005.9 12179.9 12232.4 10177.6 10373.2 10388.5 10585.4 10895.5 10917.9 10979.2 10995.2 11036.3 11135.9 16:35:55 INFO - PROCESS | 12918 | -------- Summary: end -------- 16:35:55 INFO - PROCESS | 12918 | 16:35:56 INFO - TEST-INFO | 12918: exit 0 16:35:56 INFO - TEST-OK | dromaeo_css | took 1111207ms 16:35:56 INFO - TEST-START | kraken 16:35:56 INFO - operating with platform_type : linux_ 16:35:56 INFO - Initialising browser for kraken test... 16:35:56 INFO - TEST-INFO | started process 13153 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppZRu4t/profile http://localhost:47460/getInfo.html) 16:36:01 INFO - PROCESS | 13153 | __metrics Screen width/height:1600/1200 16:36:01 INFO - PROCESS | 13153 | colorDepth:24 16:36:01 INFO - PROCESS | 13153 | Browser inner width/height: 1024/697 16:36:01 INFO - PROCESS | 13153 | __metrics 16:36:01 ERROR - PROCESS | 13153 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 16:36:02 INFO - TEST-INFO | 13153: exit 0 16:36:02 INFO - Browser initialized. 16:36:02 INFO - Running cycle 1/1 for kraken test... 16:36:02 INFO - TEST-INFO | started process 13272 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppZRu4t/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:36:14 INFO - PROCESS | 13272 | RSS: Main: 167116800 16:36:14 INFO - PROCESS | 13272 | 16:36:17 INFO - PROCESS | 13272 | Cycle 1(1): loaded http://localhost:47460/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47460/tests/kraken/driver.html?testName=audio-beat-detection) 16:36:18 INFO - PROCESS | 13272 | RSS: Main: 172744704 16:36:18 INFO - PROCESS | 13272 | 16:36:20 INFO - PROCESS | 13272 | Cycle 1(1): loaded http://localhost:47460/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47460/tests/kraken/driver.html?testName=audio-dft) 16:36:21 INFO - PROCESS | 13272 | RSS: Main: 171757568 16:36:21 INFO - PROCESS | 13272 | 16:36:24 INFO - PROCESS | 13272 | Cycle 1(1): loaded http://localhost:47460/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47460/tests/kraken/driver.html?testName=audio-fft) 16:36:24 INFO - PROCESS | 13272 | RSS: Main: 166817792 16:36:24 INFO - PROCESS | 13272 | 16:36:27 INFO - PROCESS | 13272 | Cycle 1(1): loaded http://localhost:47460/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47460/tests/kraken/driver.html?testName=audio-oscillator) 16:36:27 INFO - PROCESS | 13272 | RSS: Main: 167268352 16:36:27 INFO - PROCESS | 13272 | 16:36:29 INFO - PROCESS | 13272 | Cycle 1(1): loaded http://localhost:47460/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47460/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:36:30 INFO - PROCESS | 13272 | RSS: Main: 167653376 16:36:30 INFO - PROCESS | 13272 | 16:36:33 INFO - PROCESS | 13272 | Cycle 1(1): loaded http://localhost:47460/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47460/tests/kraken/driver.html?testName=imaging-darkroom) 16:36:34 INFO - PROCESS | 13272 | RSS: Main: 167411712 16:36:34 INFO - PROCESS | 13272 | 16:36:37 INFO - PROCESS | 13272 | Cycle 1(1): loaded http://localhost:47460/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47460/tests/kraken/driver.html?testName=imaging-desaturate) 16:36:38 INFO - PROCESS | 13272 | RSS: Main: 168587264 16:36:38 INFO - PROCESS | 13272 | 16:36:41 INFO - PROCESS | 13272 | Cycle 1(1): loaded http://localhost:47460/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47460/tests/kraken/driver.html?testName=json-parse-financial) 16:36:41 INFO - PROCESS | 13272 | RSS: Main: 168116224 16:36:41 INFO - PROCESS | 13272 | 16:36:43 INFO - PROCESS | 13272 | Cycle 1(1): loaded http://localhost:47460/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47460/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:36:43 INFO - PROCESS | 13272 | RSS: Main: 168079360 16:36:43 INFO - PROCESS | 13272 | 16:36:45 INFO - PROCESS | 13272 | Cycle 1(1): loaded http://localhost:47460/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47460/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:36:46 INFO - PROCESS | 13272 | RSS: Main: 168493056 16:36:46 INFO - PROCESS | 13272 | 16:36:48 INFO - PROCESS | 13272 | Cycle 1(1): loaded http://localhost:47460/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47460/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:36:49 INFO - PROCESS | 13272 | RSS: Main: 168861696 16:36:49 INFO - PROCESS | 13272 | 16:36:51 INFO - PROCESS | 13272 | Cycle 1(1): loaded http://localhost:47460/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47460/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:36:52 INFO - PROCESS | 13272 | RSS: Main: 169156608 16:36:52 INFO - PROCESS | 13272 | 16:36:55 INFO - PROCESS | 13272 | Cycle 1(1): loaded http://localhost:47460/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47460/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:36:55 INFO - PROCESS | 13272 | RSS: Main: 169361408 16:36:55 INFO - PROCESS | 13272 | 16:36:57 INFO - PROCESS | 13272 | Cycle 1(1): loaded http://localhost:47460/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47460/tests/kraken/driver.html?testName=ai-astar) 16:36:57 INFO - PROCESS | 13272 | RSS: Main: 169930752 16:36:57 INFO - PROCESS | 13272 | 16:36:57 INFO - PROCESS | 13272 | __start_tp_report 16:36:57 INFO - PROCESS | 13272 | _x_x_mozilla_page_load 16:36:57 INFO - PROCESS | 13272 | _x_x_mozilla_page_load_details 16:36:57 INFO - PROCESS | 13272 | |i|pagename|runs| 16:36:57 INFO - PROCESS | 13272 | |0;ai-astar;110;106;110;109;111;119;109;110;110;110 16:36:57 INFO - PROCESS | 13272 | |1;audio-beat-detection;152;135;156;184;128;152;152;129;184;128 16:36:57 INFO - PROCESS | 13272 | |2;audio-dft;162;162;161;160;161;166;166;161;160;161 16:36:57 INFO - PROCESS | 13272 | |3;audio-fft;75;73;75;161;77;75;74;73;181;79 16:36:57 INFO - PROCESS | 13272 | |4;audio-oscillator;88;87;148;87;86;86;138;87;85;152 16:36:57 INFO - PROCESS | 13272 | |5;imaging-gaussian-blur;117;120;122;117;118;122;118;118;117;117 16:36:57 INFO - PROCESS | 13272 | |6;imaging-darkroom;147;147;146;147;147;150;153;146;146;149 16:36:57 INFO - PROCESS | 13272 | |7;imaging-desaturate;95;100;95;95;95;96;96;96;94;96 16:36:57 INFO - PROCESS | 13272 | |8;json-parse-financial;56;57;55;56;56;59;56;57;60;56 16:36:57 INFO - PROCESS | 13272 | |9;json-stringify-tinderbox;64;63;63;65;63;62;63;63;63;62 16:36:57 INFO - PROCESS | 13272 | |10;stanford-crypto-aes;81;86;81;82;86;87;81;83;120;85 16:36:57 INFO - PROCESS | 13272 | |11;stanford-crypto-ccm;136;125;132;138;131;129;132;141;130;132 16:36:57 INFO - PROCESS | 13272 | |12;stanford-crypto-pbkdf2;164;159;161;161;158;158;159;166;160;165 16:36:57 INFO - PROCESS | 13272 | |13;stanford-crypto-sha256-iterative;64;62;63;63;63;63;62;65;67;61 16:36:57 INFO - PROCESS | 13272 | __end_tp_report 16:36:57 INFO - PROCESS | 13272 | __start_cc_report 16:36:57 INFO - PROCESS | 13272 | _x_x_mozilla_cycle_collect,881 16:36:57 INFO - PROCESS | 13272 | __end_cc_report 16:36:57 INFO - PROCESS | 13272 | __startTimestamp1465256217602__endTimestamp 16:36:57 INFO - PROCESS | 13272 | 16:36:57 INFO - PROCESS | 13272 | ------- Summary: start ------- 16:36:57 INFO - PROCESS | 13272 | Number of tests: 14 16:36:57 INFO - PROCESS | 13272 | 16:36:57 INFO - PROCESS | 13272 | [#0] ai-astar Cycles:10 Average:110.40 Median:110.00 stddev:3.31 (3.0%) stddev-sans-first:3.50 16:36:57 INFO - PROCESS | 13272 | Values: 110.0 106.0 110.0 109.0 111.0 119.0 109.0 110.0 110.0 110.0 16:36:57 INFO - PROCESS | 13272 | 16:36:57 INFO - PROCESS | 13272 | [#1] audio-beat-detection Cycles:10 Average:150.00 Median:152.00 stddev:21.07 (13.9%) stddev-sans-first:22.33 16:36:57 INFO - PROCESS | 13272 | Values: 152.0 135.0 156.0 184.0 128.0 152.0 152.0 129.0 184.0 128.0 16:36:57 INFO - PROCESS | 13272 | 16:36:57 INFO - PROCESS | 13272 | [#2] audio-dft Cycles:10 Average:162.00 Median:161.50 stddev:2.21 (1.4%) stddev-sans-first:2.35 16:36:57 INFO - PROCESS | 13272 | Values: 162.0 162.0 161.0 160.0 161.0 166.0 166.0 161.0 160.0 161.0 16:36:57 INFO - PROCESS | 13272 | 16:36:57 INFO - PROCESS | 13272 | [#3] audio-fft Cycles:10 Average:94.30 Median:75.00 stddev:40.74 (54.3%) stddev-sans-first:42.61 16:36:57 INFO - PROCESS | 13272 | Values: 75.0 73.0 75.0 161.0 77.0 75.0 74.0 73.0 181.0 79.0 16:36:57 INFO - PROCESS | 13272 | 16:36:57 INFO - PROCESS | 13272 | [#4] audio-oscillator Cycles:10 Average:104.40 Median:86.50 stddev:28.92 (33.4%) stddev-sans-first:30.06 16:36:57 INFO - PROCESS | 13272 | Values: 88.0 87.0 148.0 87.0 86.0 86.0 138.0 87.0 85.0 152.0 16:36:57 INFO - PROCESS | 13272 | 16:36:57 INFO - PROCESS | 13272 | [#5] imaging-gaussian-blur Cycles:10 Average:118.60 Median:118.00 stddev:2.01 (1.7%) stddev-sans-first:2.05 16:36:57 INFO - PROCESS | 13272 | Values: 117.0 120.0 122.0 117.0 118.0 122.0 118.0 118.0 117.0 117.0 16:36:57 INFO - PROCESS | 13272 | 16:36:57 INFO - PROCESS | 13272 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:147.00 stddev:2.25 (1.5%) stddev-sans-first:2.37 16:36:57 INFO - PROCESS | 13272 | Values: 147.0 147.0 146.0 147.0 147.0 150.0 153.0 146.0 146.0 149.0 16:36:57 INFO - PROCESS | 13272 | 16:36:57 INFO - PROCESS | 13272 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:95.50 stddev:1.62 (1.7%) stddev-sans-first:1.69 16:36:57 INFO - PROCESS | 13272 | Values: 95.0 100.0 95.0 95.0 95.0 96.0 96.0 96.0 94.0 96.0 16:36:57 INFO - PROCESS | 13272 | 16:36:57 INFO - PROCESS | 13272 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:56.50 stddev:1.55 (2.7%) stddev-sans-first:1.62 16:36:57 INFO - PROCESS | 13272 | Values: 56.0 57.0 55.0 56.0 56.0 59.0 56.0 57.0 60.0 56.0 16:36:57 INFO - PROCESS | 13272 | 16:36:57 INFO - PROCESS | 13272 | [#9] json-stringify-tinderbox Cycles:10 Average:63.10 Median:63.00 stddev:0.88 (1.4%) stddev-sans-first:0.87 16:36:57 INFO - PROCESS | 13272 | Values: 64.0 63.0 63.0 65.0 63.0 62.0 63.0 63.0 63.0 62.0 16:36:57 INFO - PROCESS | 13272 | 16:36:57 INFO - PROCESS | 13272 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:84.00 stddev:11.75 (14.0%) stddev-sans-first:12.25 16:36:57 INFO - PROCESS | 13272 | Values: 81.0 86.0 81.0 82.0 86.0 87.0 81.0 83.0 120.0 85.0 16:36:57 INFO - PROCESS | 13272 | 16:36:57 INFO - PROCESS | 13272 | [#11] stanford-crypto-ccm Cycles:10 Average:132.60 Median:132.00 stddev:4.62 (3.5%) stddev-sans-first:4.74 16:36:57 INFO - PROCESS | 13272 | Values: 136.0 125.0 132.0 138.0 131.0 129.0 132.0 141.0 130.0 132.0 16:36:57 INFO - PROCESS | 13272 | 16:36:57 INFO - PROCESS | 13272 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.10 Median:161.00 stddev:2.92 (1.8%) stddev-sans-first:2.91 16:36:57 INFO - PROCESS | 13272 | Values: 164.0 159.0 161.0 161.0 158.0 158.0 159.0 166.0 160.0 165.0 16:36:57 INFO - PROCESS | 13272 | 16:36:57 INFO - PROCESS | 13272 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.00 stddev:1.70 (2.7%) stddev-sans-first:1.79 16:36:57 INFO - PROCESS | 13272 | Values: 64.0 62.0 63.0 63.0 63.0 63.0 62.0 65.0 67.0 61.0 16:36:57 INFO - PROCESS | 13272 | -------- Summary: end -------- 16:36:57 INFO - PROCESS | 13272 | 16:36:58 INFO - TEST-INFO | 13272: exit 0 16:36:58 INFO - TEST-OK | kraken | took 62176ms 16:36:58 INFO - SUITE-END | took 1173s 16:36:58 INFO - Completed test suite (00:19:33) 16:36:58 INFO - javascript benchmark 16:36:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7192.265078855042, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3137.1059248114284, 3138.2938838761297, 3158.1946603616084, 3171.6035495563056, 3181.6818318168184, 5359.7588108535165, 5423.267858839055, 5494.093474576695, 5508.91736623951, 5513.917291240635, 5399.298091248133, 5434.375046869611, 5515.062439385314, 5531.197976293435, 5545.667259964395, 4884.902301953959, 4965.205567109263, 5052.166392545226, 5072.492750724935, 5126.30794842697, 780.7250039048361, 5041.344625198719, 5072.188449848025, 5101.362329708786, 5127.564157046656, 4951.306817045616, 5000.249962505617, 5001.224810154414, 5010.774515146827, 5047.066292735855, 4917.655764096515, 5014.924776128324, 5015.699058056492, 5018.422881368653, 5040.521150490734, 4919.409670839486, 4940.975295123538, 4946.703197808107, 4958.578520825734, 4992.126377883892, 5429.185622156669, 5434.402215756264, 5436.036206956827, 5437.0, 5509.696966666832, 5708.77164913403, 5891.646501209942, 5922.733476993546, 5935.554833387513, 5947.1971283876555, 6063.242094738158, 6083.969580152071, 6090.025595904634, 6104.2980057293535, 6123.0, 5598.524125449342, 5628.831135065954, 5635.21107045014, 5667.064934285838, 5674.092145256739, 5939.821805345847, 5974.581779275409, 5993.190919225936, 6038.788642397495, 6183.412575805291, 5808.186853840466, 5812.44781745742, 5815.447532484492, 5816.970915145482, 5822.155787410802, 5883.235179426647, 5899.351071382144, 5899.557533185029, 5902.468777810018, 5909.261342332208, 5642.294713160855, 5839.240898683229, 5866.032104702762, 5916.852078698067, 5936.792212272636, 5780.508656764138, 5785.88428231433, 5858.2677165354335, 5904.704764761831, 5955.583109182402, 4329.848455304049, 4387.495438024668, 4389.275769498061, 4396.472423309224, 4413.293872980308, 3900.6294402031763, 3914.3541315683165, 3953.7825419601622, 3956.1098752780968, 3962.623550762673, 5683.26117604717, 5688.914666280009, 5689.43105689436, 5707.4577915098, 5711.114777209539, 5877.735501902424, 5957.672328021914, 5979.431953964367, 5979.970100149559, 6007.699615019232, 5606.0, 5678.772849086073, 5717.113847353667, 5735.4551317624755, 5740.425957404226, 4848.272759086095, 4857.222844344888, 4862.367892174066, 4864.708117512961, 4902.779374928136, 5916.822495325147, 6176.227971503562, 6225.595336303126, 6241.157443745127, 6252.0, 5819.039858423397, 5933.080372542263, 5947.672877991752, 5990.910136348046, 6028.246469191351, 6107.786227482017, 6161.568690191643, 6169.938300616936, 6189.783357582463, 6194.752209911553, 5674.319081710221, 5890.52875769946, 5897.0, 5910.408959104056, 5922.437368449991, 5911.438413350725, 5939.990201665813, 5965.701714914324, 5976.760929562769, 6050.697465126638, 5764.827055188351, 5820.097884827858, 5836.153757705194, 5861.589688721919, 5866.2373891393845, 5687.232223649754, 5816.389279125631, 5830.679312637845, 5834.0, 5834.854128646818, 5679.062954612443, 5709.51469125129, 5719.799807006735, 5724.74238659253, 5749.683767392667, 5808.6224395414165, 5812.534997200299, 5828.562857785599, 5837.066069428871, 5872.471477567039, 5567.498925096599, 5635.774569017193, 5706.743196556248, 5719.599628025998, 5760.308762948473], "value": 5412.084778793884, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.6310398241143, 614.1708693264093, 626.7054484392334, 631.6810010944472, 636.5607730665837, 39373.80313098434, 43047.0, 43111.35332970004, 43136.56863431365, 43200.783996080056, 43843.78078109605, 44360.334594981105, 44541.331880021826, 44795.3280700789, 44889.0, 8742.082081381459, 8900.688475903346, 8960.686375976842, 8964.820703585925, 8965.955170224172, 8685.435446695976, 8752.124787521261, 8779.868301975475, 8796.032436431988, 8805.60374783133, 8807.559622018905, 8809.559522023874, 8810.030896601369, 8824.382293239476, 8843.77890552735, 8761.34289928258, 8773.649054037864, 8803.251723603502, 8807.427517211392, 8810.38327317088, 8762.430442021248, 8852.51311177885, 8856.601452934634, 8859.867101993475, 8899.421537600036, 41443.37834932478, 41611.79194104041, 41870.0, 41894.1621167578, 41931.79034104841, 3450.585929688428, 3462.3075384922863, 3535.521705638258, 3742.288965096623, 4087.3664581989838, 32228.516572251436, 32404.0, 32688.0, 32756.836215819007, 32802.0, 4417.51407345195, 4419.160359531678, 4440.400545926291, 4537.274036154233, 4647.976760116211, 354180.0, 355209.0, 355249.0, 356207.0, 356805.0, 59654.0, 60006.0, 60045.0, 60425.97870106477, 60562.39437605656, 36168.638313617055, 36853.815730921175, 37091.629083709355, 38279.23441531154, 63246.36753632497, 15807.683846323009, 15848.683026339639, 15958.0, 15997.0, 16006.679866402606, 12026.639200823989, 12102.878971210352, 12129.21160124589, 12161.939190303992, 12184.268943863397, 19577.706334404997, 19723.605527889362, 19876.304329348404, 19885.900570497055, 19901.0, 7154.785356439315, 7216.3505284524645, 7366.815829604303, 7383.704651813868, 7439.776806695808, 1008.1128606826093, 1010.5149528226492, 1046.7121541575975, 1057.735566108473, 1149.4827327702567, 32783.83608081992, 32876.0, 32999.67000330014, 33154.0, 33179.66820331814, 1102.8640500284719, 1121.1815374776295, 1163.6101905861462, 1196.4556126962211, 1203.506562309449, 16788.916055419646, 17421.65156696884, 17441.12794360277, 17540.386086486913, 17687.115644217996, 535894.0, 539961.0, 542477.0, 542649.7205083775, 544785.0, 58458.0, 59782.70108649516, 59906.70046649739, 60106.0, 60232.39767602355, 1269.6127681057367, 1339.0894191949567, 1348.6089034180175, 1388.5834249725042, 1392.714493528824, 31597.526037109, 32135.357292853543, 32640.83679581587, 32720.527576259603, 32843.343133136725, 52398.47601523936, 52498.0, 52504.73747631237, 52666.73666631642, 52825.47174528359, 452109.0, 453320.0, 453561.0, 453733.0, 453969.0, 27946.860265698542, 27997.860010699816, 28241.57637635396, 28401.57397638996, 28755.0, 48884.0, 48927.26609100938, 49532.25701614551, 49821.25268120909, 50278.0, 42188.578114218464, 42715.57284427116, 43035.78482107569, 43164.0, 43488.0, 40471.0, 41548.691976391434, 41936.191425722835, 42088.0, 42244.577554224066, 36367.0, 40572.0, 41014.0, 41300.173996520505, 42027.7898610505, 36962.630373695916, 37331.2533749318, 37469.81265093657, 38386.42420363753, 38460.80769596134, 28137.296567585974, 28639.284017899718, 28846.567301490075, 28867.56698649564, 28904.0], "value": 20151.91906342628, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.8939186419669, 393.77948348924593, 398.41632009106655, 398.70695039146204, 419.35210100394886, 13870.514531991383, 18165.909170454128, 18604.62790744186, 19352.12915418806, 19400.417987460365, 18240.452786416394, 18306.72539911899, 18569.44291671252, 19399.612007759835, 19425.4172374829, 5500.944990550103, 5669.773209071632, 5748.770049198027, 5800.854978625547, 5865.472107510323, 5277.498637629438, 5610.719464026803, 5695.0, 5705.942940570582, 5739.971300143514, 5636.4927156555905, 5638.520725738317, 5644.463775941279, 5647.237622920894, 5651.858703532424, 5613.80351687691, 5845.415458454163, 5869.442402971711, 5869.677167755772, 5872.177895094669, 5464.0711079116645, 5633.746481408347, 5644.858878528029, 5648.068068768689, 5654.491095801356, 13584.184948903, 14108.365123569463, 14121.293935303296, 14228.786568201382, 14303.213323267217, 2124.936251912445, 2171.9565608687894, 2216.789405006538, 2320.5938960681815, 2465.938351541226, 9727.07592778685, 9749.561269742879, 9920.95039524805, 11350.262232954832, 12608.873911260862, 1681.9495415137565, 1731.8008429030697, 1847.565920914688, 1925.86518943674, 1947.9902600486907, 75609.0, 79767.0, 82964.58517707433, 84251.0, 84778.57610711906, 10387.68836934893, 10588.205884558689, 10637.149028077734, 10760.623378181883, 11133.10935125188, 14989.400423983137, 15045.699086018438, 15123.773143402857, 15178.848211517743, 15197.772033419507, 7637.579933103732, 7908.881366779503, 7921.049474063149, 7982.640781164861, 8049.919500805034, 7511.3615342696485, 7537.54774713519, 7556.622168891534, 7719.691212351556, 7728.111267204231, 4526.434195725535, 4559.3844830948065, 4606.147862645421, 4684.789184486706, 4689.1559519286175, 1894.3085773692503, 1942.6988816733428, 1952.1800843645703, 1955.511122219445, 1990.3630838131949, 897.4166791585391, 1027.209049032241, 1046.4924511611862, 1068.6954218047974, 1096.155959910864, 17078.658426831393, 18217.635647287247, 18907.14917828701, 19168.0, 19248.326308579133, 965.2953344058876, 992.925530585209, 1000.6297669862198, 1019.8113349030305, 1055.0, 9680.806383872283, 10619.0, 10793.892061079288, 10814.62148824803, 10815.080718139046, 460897.0, 467714.0, 469146.0, 469500.0, 472178.0, 54320.45679543154, 71869.0, 87791.0, 95924.52037739767, 97476.0, 944.3767113704922, 973.7127547373542, 992.8758905136858, 993.1905497019906, 1017.2828156149749, 16314.755278671068, 17270.309187632352, 17306.0, 17548.736768948733, 17867.821321787134, 42610.78694606507, 43955.34066989062, 44044.0, 44107.0, 44937.0, 56611.71694141503, 57050.714746427664, 58141.709291454965, 58389.4161058401, 58608.70695646494, 8394.328453723565, 8576.571171441277, 8591.140885911358, 8639.827203456021, 8676.741872428589, 9478.052194780466, 12678.936605316914, 13083.672908176992, 13275.734485310433, 13325.466981320638, 11098.778024439627, 11376.317420954769, 11412.714682133013, 11538.826917596074, 11676.06591472697, 11334.546618135182, 11521.884781152416, 11534.942325288655, 11799.764004719686, 11881.82177267359, 11018.559257629606, 11279.379634120201, 11572.24780389272, 11649.941750291195, 11687.88312116868, 8513.659453622033, 8610.870836937576, 8658.48049117055, 8705.695300664447, 8742.562871856255, 11353.489092991, 11446.65660030167, 11457.713557161138, 11495.252808567417, 11663.183577149519], "value": 8953.282376514244, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1361.8570050144738, 1442.5023366938406, 1531.463987604338, 1806.7199584064474, 1819.7634307540018, 7740.187280335568, 8273.131321211276, 8328.541930193836, 8871.733847984562, 8880.8667869982, 8387.83224335513, 8527.87208191876, 8672.523011234396, 8689.217970382664, 8798.340124490656, 2316.6756654068486, 2360.775726305998, 2375.988120059406, 2382.0, 2385.105585405473, 2324.070371851256, 2341.695579574653, 2368.8223383246327, 2379.988100059506, 2380.178838300792, 2309.0648287443614, 2313.375388645065, 2317.3279748872806, 2326.395137264315, 2337.0885354711677, 2275.6358982562874, 2276.3171048685413, 2290.473191166033, 2299.5515874404414, 2309.2379514760087, 2282.463621049052, 2316.6061769499224, 2336.6378211377264, 2347.14329269817, 2350.6239001759636, 8416.074231834493, 8461.407701460901, 8486.108958559324, 8486.236238738482, 8493.447925884859, 4858.781354839005, 5097.0, 5163.199704045879, 5167.0957582422925, 5182.922256166161, 3208.9358212835846, 3212.6947939945667, 3264.722498587623, 3269.084656296241, 3290.3583801158784, 1085.7882712870994, 1116.681745702479, 1119.0376276402287, 1149.7413082056555, 1162.1690491298762, 11278.661640150809, 11329.830052549136, 11335.603253886075, 11388.943055284753, 11392.772144557146, 4561.794719237642, 4652.767361631905, 4717.386739723814, 4736.218523943579, 4751.809927602857, 9625.278104142217, 9628.807423851484, 9646.421214727, 9649.179819715402, 9669.371490853073, 5213.530782229542, 5214.374275086938, 5220.843374698765, 5251.343582052244, 5256.92114618281, 4259.190753756776, 4698.671093023524, 4717.716936983792, 4807.735574543363, 4907.1903135982875, 4035.757854528738, 4099.733517321364, 4105.774182419936, 4106.835726570904, 4275.615194632436, 1308.8952883769275, 1316.6115995781267, 1318.2156616812981, 1318.9274589897648, 1331.0483004651721, 753.5892938348613, 868.2055918834322, 874.6851133591902, 961.3943215774158, 985.3447457440865, 5630.774769009194, 5767.884642307215, 6008.429199226067, 6009.579329446984, 6095.085737139465, 895.1317222294364, 1012.2307046644603, 1014.4369874719454, 1021.341234903483, 1047.4657924458581, 4137.0, 4382.53983331752, 4397.922508985255, 4407.449068866392, 4454.131444368382, 10047.246456515644, 10070.194384449227, 10088.092071713581, 10137.0, 10156.613195898957, 10074.0, 10088.192944564416, 10089.596416143419, 10096.899031009743, 10097.5456104474, 7744.690212391554, 7812.218778122256, 7842.45102842807, 7880.960595197102, 7886.211378862183, 6081.239845019372, 6095.420935011344, 6109.51123910095, 6119.357467465852, 6281.183446151971, 9967.651132210338, 10141.29010969225, 10236.33463824849, 10267.178625710074, 10289.897101029193, 10076.395416275047, 10247.077763001365, 10253.74365640865, 10402.323848949794, 10433.061024507831, 7010.75462358815, 7166.605836678824, 7387.445941554298, 7893.486923349964, 8050.5572193529915, 7926.128125906031, 7938.0, 7950.403719720928, 7978.880316795136, 8007.679692812222, 7031.894521582282, 7334.0, 7402.259774022555, 7477.214892436215, 7511.887321690288, 7278.927210728037, 7319.963400182965, 7574.659140338808, 7691.961540192263, 7714.845703086019, 6881.41507971828, 6885.449164066963, 6896.344847239504, 6906.37842594169, 6918.342757438036, 4927.359443272351, 5178.43037265908, 5219.112750832443, 5237.319148510669, 5271.4464981176425, 5045.091883461012, 5097.311862898461, 5178.559822415137, 5239.89520209586, 5302.840914772563], "value": 4578.723014531184, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.10260604186817, 336.10595815131757, 339.84452860275064, 343.1284537275319, 343.21232770791033, 5533.557315414767, 5642.605017648756, 5663.461971112738, 5675.524363665446, 5693.3452652944925, 5501.339839219299, 5529.889402211953, 5560.805371811987, 5585.636933599313, 5601.3558440779325, 4130.917381652373, 4151.712968979611, 4324.286492728696, 4350.238708226064, 4366.628836548881, 4318.611324980751, 4324.616122840692, 4337.414449049385, 4341.630961368288, 4347.7173983690955, 4310.547392523787, 4320.65434765218, 4329.523752387251, 4331.610155086041, 4345.044090300129, 4007.8597249096288, 4273.55127711592, 4281.314989601648, 4286.742795432284, 4310.499910052162, 3733.607971163043, 3739.476473293741, 3765.5104836371097, 3771.7171212159196, 3794.1273507093524, 5401.675899446007, 5437.8368648940595, 5443.455654434564, 5473.370562385337, 5487.341519017704, 4886.193778026622, 4906.362172917534, 4912.36139301892, 4981.252812078181, 5019.322391477141, 5891.263592050994, 5913.46778789911, 5938.613990090674, 5941.702914854283, 5945.881082378328, 4169.812358443877, 4181.811818468146, 4187.664986801049, 4208.937620565931, 4211.347241177622, 5973.731182096816, 6097.878042439126, 6099.597092668667, 6099.847503812396, 6161.137440758297, 4267.466566679165, 4277.5617897798575, 4278.165757677285, 4293.914121717548, 4302.204092242945, 4299.441072660534, 4316.2446571849805, 4322.783860806947, 4333.349997500401, 4338.76136812472, 4843.903121937541, 4908.828191013369, 4911.0423467424225, 4930.9013819723405, 4951.405831300267, 5842.678652674143, 5865.501432378295, 5873.471387575139, 5919.6744179070565, 5995.910061349084, 1477.933492992818, 1485.8633145643591, 1497.3636204613213, 1497.5058230783816, 1503.646643038885, 927.3091546797544, 945.7824700318965, 949.7131386970693, 951.1439704266215, 957.2820384711466, 5092.363454568179, 5157.871053223699, 5205.349331333583, 5228.607854410859, 5254.894902102013, 5395.379531353866, 5412.323459567554, 5438.253681890699, 5440.319960004999, 5461.918071228934, 4945.530174633404, 5090.847274581768, 5129.589632829439, 5150.562202212854, 5236.92144617831, 2892.3492214251623, 2910.2287893708185, 2914.7757941664554, 2960.48191566475, 2964.6590642076007, 5453.263809385761, 5462.317210348707, 5492.951411966317, 5583.804566840141, 5604.523615492647, 5507.779688812483, 5603.215549823028, 5608.270924779834, 5616.438356164433, 5627.383266780967, 5489.721765467366, 5653.547716182696, 5659.43405659439, 5679.608495918444, 5687.895478672917, 5249.580033597226, 5297.258383826191, 5362.973185134206, 5509.917351239655, 5523.834284971457, 5301.655392399482, 5455.863603409946, 5460.399356070909, 5467.890642187054, 5470.562355011669, 5540.473655002768, 5548.446434998207, 5561.944380556142, 5566.940232113981, 5576.10782274834, 3608.9819550902075, 3847.96152038476, 3875.554311254242, 3923.372260438316, 3924.9018774530864, 5174.482551744946, 5336.825898302523, 5405.783768649368, 5837.211976383134, 5995.790147344822, 5911.793087241926, 5938.673372964356, 5951.523878089656, 5982.52139828804, 5994.831007953581, 5838.474537291664, 5871.706414679164, 5893.909626719071, 5962.493188078888, 6005.069214271794, 5628.915566266591, 5846.181534585076, 5864.9413505864395, 5879.441453061952, 5891.410858914074, 5945.583809133319, 5988.580799344004, 5994.82015539517, 6011.969940150271, 6025.939740602538, 5609.102543593006, 5833.649981001154, 5861.3845546217035, 5880.294364676095, 5893.528517718487], "value": 4321.064725067823, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [626.4236902050113, 627.4353082225999, 686.7914056925395, 698.5180225644305, 768.6195333310012, 14997.5500734978, 15743.527694169165, 15744.0, 15800.920995395021, 15814.130222837739, 14472.276386180702, 14642.707145857077, 14703.264836758146, 14806.777898331507, 14829.555113346616, 822.3585603229491, 823.6664151018817, 829.6308142876422, 830.2693629605968, 830.6635812495949, 806.3589446390105, 806.9435139540235, 808.3048578222753, 808.8988876390451, 814.6089876859111, 846.3398549131687, 852.5651917522047, 855.8117214212895, 856.3149480415674, 857.3227150551088, 842.5913431985482, 848.499385362639, 853.6500034985658, 854.8247609240091, 855.055164043732, 612.3111499562991, 616.014376996806, 617.6541136963315, 618.4959258204549, 619.5105866365566, 14502.854971450255, 14710.411583536647, 14719.411223551046, 14753.557393278219, 14761.33573989173, 14178.14931104137, 14190.929045354811, 14282.785758213635, 14415.207163605997, 14437.35031923566, 10637.73405664857, 10721.012170093012, 10749.677509674722, 11206.15953803468, 11241.775164496665, 3632.963670363289, 3687.649673281034, 3709.5733990591157, 3716.6655001050035, 3747.400415933465, 50627.74686126583, 60496.69751651258, 62455.0, 63377.36622633761, 73829.26170738277, 10345.534450949724, 10375.429351385746, 10607.628732994463, 10863.565457381774, 11395.259308144945, 17781.0, 17816.198271077832, 17883.910580447013, 17923.28306867711, 18185.63628727418, 8155.877661835078, 8204.548749818698, 8488.575571221538, 8490.872636910452, 8686.782830429163, 4661.86014419568, 4701.929471057937, 4710.222813235778, 4732.266498692708, 4885.8289959851945, 3550.5739311282296, 3626.673599376069, 3629.256002519477, 3636.2727454509204, 3651.744377893575, 627.5310667532386, 630.5460068750492, 639.0829160155192, 645.096864389858, 652.5921299188008, 595.4161929268213, 607.76601008612, 670.483727529809, 675.0043685563754, 693.0505207865156, 9117.81764364709, 9201.585928633227, 9558.235341172689, 9589.520523973913, 9740.805183896282, 620.5780069552658, 634.5336177909234, 654.2835595023441, 691.975780847678, 693.2547511425238, 4189.476315460567, 4199.286121359376, 4272.572742725764, 4302.440682711227, 4444.0, 63958.36041639617, 65950.0, 108217.0, 109312.4534377323, 112659.0, 59986.400135998956, 63342.999999999076, 64329.356706433275, 72798.0, 82399.76400354, 86461.0, 88104.5594772022, 88155.55922220348, 88621.0, 89567.55216224007, 9223.845896715698, 9316.906830931875, 9589.664361747584, 9593.42439453635, 9993.550290236812, 50896.49103508917, 52644.0, 52961.470385297194, 53620.73189634027, 53746.46253537571, 72749.0, 76877.0, 77312.2268777305, 78853.0, 79513.0, 11621.302721836717, 12292.938535307267, 12671.746565068463, 12720.173188742701, 12901.354932253162, 13629.386677599334, 13673.521426750016, 13917.4433022682, 13942.0, 13980.510682126076, 12687.80968285458, 12997.545085921947, 13048.282344470765, 13053.216806991612, 13229.735405292033, 11295.0, 11750.70623234426, 11999.100067495147, 12416.068794840603, 12433.06751993586, 11628.883711163118, 11832.940835295769, 12005.939970300093, 12179.878201217874, 12232.449539770909, 10177.592896284066, 10373.170146388422, 10388.532516036645, 10585.417802020962, 10895.455227238765, 10917.890821091687, 10979.231453798158, 10995.198538210752, 11036.337819730841, 11135.888641113484], "value": 7163.936311665441, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1547.3999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 106.0, 110.0, 109.0, 111.0, 119.0, 109.0, 110.0, 110.0, 110.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 135.0, 156.0, 184.0, 128.0, 152.0, 152.0, 129.0, 184.0, 128.0], "value": 150.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 160.0, 161.0, 166.0, 166.0, 161.0, 160.0, 161.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 75.0, 161.0, 77.0, 75.0, 74.0, 73.0, 181.0, 79.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 148.0, 87.0, 86.0, 86.0, 138.0, 87.0, 85.0, 152.0], "value": 104.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 120.0, 122.0, 117.0, 118.0, 122.0, 118.0, 118.0, 117.0, 117.0], "value": 118.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 147.0, 150.0, 153.0, 146.0, 146.0, 149.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 100.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 94.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 55.0, 56.0, 56.0, 59.0, 56.0, 57.0, 60.0, 56.0], "value": 56.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 65.0, 63.0, 62.0, 63.0, 63.0, 63.0, 62.0], "value": 63.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 86.0, 81.0, 82.0, 86.0, 87.0, 81.0, 83.0, 120.0, 85.0], "value": 87.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 125.0, 132.0, 138.0, 131.0, 129.0, 132.0, 141.0, 130.0, 132.0], "value": 132.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 159.0, 161.0, 161.0, 158.0, 158.0, 159.0, 166.0, 160.0, 165.0], "value": 161.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 63.0, 63.0, 63.0, 63.0, 62.0, 65.0, 67.0, 61.0], "value": 63.3, "unit": "score"}]}]} 16:36:58 INFO - Return code: 0 16:36:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:36:58 ERROR - # TBPL SUCCESS # 16:36:58 INFO - Running post-action listener: _resource_record_post_action 16:36:58 INFO - ##### 16:36:58 INFO - ##### Finished run-tests step (success) 16:36:58 INFO - ##### 16:36:58 INFO - Running post-run listener: _resource_record_post_run 16:36:58 INFO - Total resource usage - Wall time: 1191s; CPU: 14.0%; Read bytes: 139264; Write bytes: 541593600; Read time: 132; Write time: 460080 16:36:58 INFO - TinderboxPrint: CPU usage
13.5% 16:36:58 INFO - TinderboxPrint: I/O read bytes / time
139,264 / 132 16:36:58 INFO - TinderboxPrint: I/O write bytes / time
541,593,600 / 460,080 16:36:58 INFO - TinderboxPrint: CPU idle
8,212.6 (86.4%) 16:36:58 INFO - TinderboxPrint: CPU user
1,232.8 (13.0%) 16:36:58 INFO - TinderboxPrint: Swap in / out
0 / 0 16:36:58 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 131072; Write bytes: 248135680; Read time: 68; Write time: 260512 16:36:58 INFO - run-tests - Wall time: 1175s; CPU: 14.0%; Read bytes: 8192; Write bytes: 293457920; Read time: 64; Write time: 199568 16:36:59 INFO - Running post-run listener: _upload_blobber_files 16:36:59 INFO - Blob upload gear active. 16:36:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:36:59 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 16:36:59 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:36:59 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:36:59 INFO - (blobuploader) - INFO - Open directory for files ... 16:36:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:36:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:36:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:37:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:37:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:37:01 INFO - (blobuploader) - INFO - Done attempting. 16:37:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:37:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:37:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:37:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:37:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:37:01 INFO - (blobuploader) - INFO - Done attempting. 16:37:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:37:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:37:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:37:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:37:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:37:06 INFO - (blobuploader) - INFO - Done attempting. 16:37:06 INFO - (blobuploader) - INFO - Iteration through files over. 16:37:06 INFO - Return code: 0 16:37:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:37:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:37:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86a8f49547adc9dd405c0d35d1f8cc4045675eaf818d571381e0ca610b854ab1568a2ea4f898fb04fc475250f6cc6c062f4c04e94271b3129caa23d082c9cbc0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51112ae14383fcf156ee978501bbec1abe2de0e614739ba70b3e24fed00deb069571070f3ededb44c3687bd3149e4b8211adde03e8450d31f53eab3048975686", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb04b545044ea18024f479298ced042c2d42c47c3b3718a97af019c5a1244549e1e3b91bb517423657c321e76fda9613b1af344308cf984827e89b78eebf1de4"} 16:37:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:37:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:37:06 INFO - Contents: 16:37:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86a8f49547adc9dd405c0d35d1f8cc4045675eaf818d571381e0ca610b854ab1568a2ea4f898fb04fc475250f6cc6c062f4c04e94271b3129caa23d082c9cbc0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51112ae14383fcf156ee978501bbec1abe2de0e614739ba70b3e24fed00deb069571070f3ededb44c3687bd3149e4b8211adde03e8450d31f53eab3048975686", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb04b545044ea18024f479298ced042c2d42c47c3b3718a97af019c5a1244549e1e3b91bb517423657c321e76fda9613b1af344308cf984827e89b78eebf1de4"} 16:37:06 INFO - Running post-run listener: copy_logs_to_upload_dir 16:37:06 INFO - Copying logs to upload dir... 16:37:06 INFO - mkdir: /builds/slave/test/build/upload/logs 16:37:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.988439 ========= master_lag: 29.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-06-06 16:37:35.686128) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 16:37:35.690240) ========= 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=7de08804244eb36560b44971000001c3-1465254989.529956-2012116812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86a8f49547adc9dd405c0d35d1f8cc4045675eaf818d571381e0ca610b854ab1568a2ea4f898fb04fc475250f6cc6c062f4c04e94271b3129caa23d082c9cbc0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51112ae14383fcf156ee978501bbec1abe2de0e614739ba70b3e24fed00deb069571070f3ededb44c3687bd3149e4b8211adde03e8450d31f53eab3048975686", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb04b545044ea18024f479298ced042c2d42c47c3b3718a97af019c5a1244549e1e3b91bb517423657c321e76fda9613b1af344308cf984827e89b78eebf1de4"} build_url:https://queue.taskcluster.net/v1/task/awSUdZrnQOy6Jh_56Jjgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011269 build_url: 'https://queue.taskcluster.net/v1/task/awSUdZrnQOy6Jh_56Jjgwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86a8f49547adc9dd405c0d35d1f8cc4045675eaf818d571381e0ca610b854ab1568a2ea4f898fb04fc475250f6cc6c062f4c04e94271b3129caa23d082c9cbc0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51112ae14383fcf156ee978501bbec1abe2de0e614739ba70b3e24fed00deb069571070f3ededb44c3687bd3149e4b8211adde03e8450d31f53eab3048975686", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb04b545044ea18024f479298ced042c2d42c47c3b3718a97af019c5a1244549e1e3b91bb517423657c321e76fda9613b1af344308cf984827e89b78eebf1de4"}' ========= master_lag: 0.69 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 16:37:36.392382) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-06-06 16:37:36.395716) ========= 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=7de08804244eb36560b44971000001c3-1465254989.529956-2012116812 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 2.12 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-06-06 16:37:38.523147) ========= ========= Started reboot skipped (results: 3, elapsed: 1 secs) (at 2016-06-06 16:37:38.523416) ========= ========= Finished reboot skipped (results: 3, elapsed: 1 secs) (at 2016-06-06 16:37:39.780836) ========= ========= Total master_lag: 32.01 =========