builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-008 starttime: 1449073699.54 results: success (0) buildid: 20151202075221 builduid: 7a9ec2fab2f045b784918bffe58d8b88 revision: 2d33fa3346b2e4bfd7720a9f1f19e4a59b84e143 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-02 08:28:19.541221) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-02 08:28:19.541681) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-02 08:28:19.542011) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=7d909545e45784438f4e8e36000001b3-1449073098.408375-644269301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004862 basedir: '/builds/slave/test' ========= master_lag: 0.09 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-02 08:28:19.635836) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-02 08:28:19.636151) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-02 08:28:19.654289) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 08:28:19.654538) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=7d909545e45784438f4e8e36000001b3-1449073098.408375-644269301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 08:28:19.706073) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-02 08:28:19.706337) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-02 08:28:19.706695) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 08:28:19.706962) ========= 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=7d909545e45784438f4e8e36000001b3-1449073098.408375-644269301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-02 08:28:19-- 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% 221M=0s 2015-12-02 08:28:19 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.169170 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 08:28:19.888740) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 08:28:19.889146) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=7d909545e45784438f4e8e36000001b3-1449073098.408375-644269301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019144 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 08:28:19.938737) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 08:28:19.939112) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2d33fa3346b2e4bfd7720a9f1f19e4a59b84e143 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 2d33fa3346b2e4bfd7720a9f1f19e4a59b84e143 --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=7d909545e45784438f4e8e36000001b3-1449073098.408375-644269301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-02 08:28:20,035 truncating revision to first 12 chars 2015-12-02 08:28:20,035 Setting DEBUG logging. 2015-12-02 08:28:20,035 attempt 1/10 2015-12-02 08:28:20,035 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2d33fa3346b2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-02 08:28:20,642 unpacking tar archive at: fx-team-2d33fa3346b2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.885981 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 08:28:20.838737) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-02 08:28:20.839097) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-02 08:28:20.855637) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-02 08:28:20.855933) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-02 08:28:20.856346) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-02 08:28:20.856676) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=7d909545e45784438f4e8e36000001b3-1449073098.408375-644269301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:28:21 INFO - MultiFileLogger online at 20151202 08:28:21 in /builds/slave/test 08:28:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:28:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:28:21 INFO - {'append_to_log': False, 08:28:21 INFO - 'base_work_dir': '/builds/slave/test', 08:28:21 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:28:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:28:21 INFO - 'branch': 'Fx-Team-Non-PGO', 08:28:21 INFO - 'buildbot_json_path': 'buildprops.json', 08:28:21 INFO - 'config_files': ('talos/linux_config.py',), 08:28:21 INFO - 'default_actions': ('clobber', 08:28:21 INFO - 'read-buildbot-config', 08:28:21 INFO - 'download-and-extract', 08:28:21 INFO - 'populate-webroot', 08:28:21 INFO - 'create-virtualenv', 08:28:21 INFO - 'install', 08:28:21 INFO - 'run-tests'), 08:28:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:28:21 INFO - 'download_minidump_stackwalk': True, 08:28:21 INFO - 'download_symbols': 'ondemand', 08:28:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:28:21 INFO - 'tooltool.py': '/tools/tooltool.py', 08:28:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:28:21 INFO - '/tools/misc-python/virtualenv.py')}, 08:28:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:28:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:28:21 INFO - 'installer_path': 'installer.exe', 08:28:21 INFO - 'log_level': 'info', 08:28:21 INFO - 'log_name': 'talos', 08:28:21 INFO - 'log_to_console': True, 08:28:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:28:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:28:21 INFO - 'opt_config_files': (), 08:28:21 INFO - 'pip_index': False, 08:28:21 INFO - 'sps_profile': False, 08:28:21 INFO - 'sps_profile_interval': 0, 08:28:21 INFO - 'suite': 'dromaeojs-e10s', 08:28:21 INFO - 'system_bits': '64', 08:28:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:28:21 INFO - 'title': 'talos-linux64-ix-008', 08:28:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:28:21 INFO - 'use_talos_json': True, 08:28:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:28:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:28:21 INFO - 'work_dir': 'build'} 08:28:21 INFO - ##### 08:28:21 INFO - ##### Running clobber step. 08:28:21 INFO - ##### 08:28:21 INFO - Running pre-action listener: _resource_record_pre_action 08:28:21 INFO - Running main action method: clobber 08:28:21 INFO - rmtree: /builds/slave/test/build 08:28:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:28:21 INFO - Running post-action listener: _resource_record_post_action 08:28:21 INFO - ##### 08:28:21 INFO - ##### Running read-buildbot-config step. 08:28:21 INFO - ##### 08:28:21 INFO - Running pre-action listener: _resource_record_pre_action 08:28:21 INFO - Running main action method: read_buildbot_config 08:28:21 INFO - Using buildbot properties: 08:28:21 INFO - { 08:28:21 INFO - "properties": { 08:28:21 INFO - "buildnumber": 781, 08:28:21 INFO - "product": "firefox", 08:28:21 INFO - "script_repo_revision": "production", 08:28:21 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:28:21 INFO - "repository": "", 08:28:21 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 08:28:21 INFO - "buildid": "20151202075221", 08:28:21 INFO - "slavename": "talos-linux64-ix-008", 08:28:21 INFO - "pgo_build": "False", 08:28:21 INFO - "basedir": "/builds/slave/test", 08:28:21 INFO - "project": "", 08:28:21 INFO - "platform": "ubuntu64_hw", 08:28:21 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:28:21 INFO - "slavebuilddir": "test", 08:28:21 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:28:21 INFO - "branch": "fx-team", 08:28:21 INFO - "repo_path": "integration/fx-team", 08:28:21 INFO - "stage_platform": "linux64", 08:28:21 INFO - "builduid": "7a9ec2fab2f045b784918bffe58d8b88", 08:28:21 INFO - "revision": "2d33fa3346b2e4bfd7720a9f1f19e4a59b84e143" 08:28:21 INFO - }, 08:28:21 INFO - "sourcestamp": { 08:28:21 INFO - "repository": "", 08:28:21 INFO - "hasPatch": false, 08:28:21 INFO - "project": "", 08:28:21 INFO - "branch": "fx-team-linux64-talos", 08:28:21 INFO - "changes": [ 08:28:21 INFO - { 08:28:21 INFO - "category": null, 08:28:21 INFO - "files": [ 08:28:21 INFO - { 08:28:21 INFO - "url": null, 08:28:21 INFO - "name": "https://queue.taskcluster.net/v1/task/RX5nd2QMT0G5GgqbG5b18g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 08:28:21 INFO - } 08:28:21 INFO - ], 08:28:21 INFO - "repository": "", 08:28:21 INFO - "rev": "2d33fa3346b2e4bfd7720a9f1f19e4a59b84e143", 08:28:21 INFO - "who": "florian@queze.net", 08:28:21 INFO - "when": 1449073650, 08:28:21 INFO - "number": 6733444, 08:28:21 INFO - "comments": "Bug 1227045 - fix intermittent test failures due to the cache file not being consistently saved before test-triggered restarts, r=mak.", 08:28:21 INFO - "project": "", 08:28:21 INFO - "at": "Wed 02 Dec 2015 08:27:30", 08:28:21 INFO - "branch": "fx-team-linux64-talos", 08:28:21 INFO - "revlink": "", 08:28:21 INFO - "properties": [ 08:28:21 INFO - [ 08:28:21 INFO - "buildid", 08:28:21 INFO - "20151202075221", 08:28:21 INFO - "Change" 08:28:21 INFO - ], 08:28:21 INFO - [ 08:28:21 INFO - "builduid", 08:28:21 INFO - "7a9ec2fab2f045b784918bffe58d8b88", 08:28:21 INFO - "Change" 08:28:21 INFO - ], 08:28:21 INFO - [ 08:28:21 INFO - "pgo_build", 08:28:21 INFO - "False", 08:28:21 INFO - "Change" 08:28:21 INFO - ] 08:28:21 INFO - ], 08:28:21 INFO - "revision": "2d33fa3346b2e4bfd7720a9f1f19e4a59b84e143" 08:28:21 INFO - } 08:28:21 INFO - ], 08:28:21 INFO - "revision": "2d33fa3346b2e4bfd7720a9f1f19e4a59b84e143" 08:28:21 INFO - } 08:28:21 INFO - } 08:28:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/RX5nd2QMT0G5GgqbG5b18g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 08:28:21 INFO - Running post-action listener: _resource_record_post_action 08:28:21 INFO - ##### 08:28:21 INFO - ##### Running download-and-extract step. 08:28:21 INFO - ##### 08:28:21 INFO - Running pre-action listener: _resource_record_pre_action 08:28:21 INFO - Running main action method: download_and_extract 08:28:21 INFO - mkdir: /builds/slave/test/build/tests 08:28:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:21 INFO - https://queue.taskcluster.net/v1/task/RX5nd2QMT0G5GgqbG5b18g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:28:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RX5nd2QMT0G5GgqbG5b18g/artifacts/public/build/test_packages.json 08:28:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RX5nd2QMT0G5GgqbG5b18g/artifacts/public/build/test_packages.json 08:28:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RX5nd2QMT0G5GgqbG5b18g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:28:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RX5nd2QMT0G5GgqbG5b18g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:28:22 INFO - Downloaded 1302 bytes. 08:28:22 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:28:22 INFO - Using the following test package requirements: 08:28:22 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:28:22 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:28:22 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:28:22 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:28:22 INFO - u'jsshell-linux-x86_64.zip'], 08:28:22 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:28:22 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:28:22 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:28:22 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:28:22 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:28:22 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:28:22 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:28:22 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:28:22 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:28:22 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:28:22 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:28:22 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:28:22 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:28:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:22 INFO - https://queue.taskcluster.net/v1/task/RX5nd2QMT0G5GgqbG5b18g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:28:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RX5nd2QMT0G5GgqbG5b18g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:28:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RX5nd2QMT0G5GgqbG5b18g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:28:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RX5nd2QMT0G5GgqbG5b18g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:28:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RX5nd2QMT0G5GgqbG5b18g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:28:23 INFO - Downloaded 21774886 bytes. 08:28:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 08:28:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:28:23 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 08:28:24 INFO - Return code: 0 08:28:24 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:28: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')]} 08:28:24 INFO - https://queue.taskcluster.net/v1/task/RX5nd2QMT0G5GgqbG5b18g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:28:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RX5nd2QMT0G5GgqbG5b18g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:28:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RX5nd2QMT0G5GgqbG5b18g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:28:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RX5nd2QMT0G5GgqbG5b18g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:28:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RX5nd2QMT0G5GgqbG5b18g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:28:25 INFO - Downloaded 21774886 bytes. 08:28:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 08:28:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:28:25 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 08:28:27 INFO - Return code: 0 08:28:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:27 INFO - https://queue.taskcluster.net/v1/task/RX5nd2QMT0G5GgqbG5b18g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:28:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RX5nd2QMT0G5GgqbG5b18g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:28:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RX5nd2QMT0G5GgqbG5b18g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:28:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RX5nd2QMT0G5GgqbG5b18g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:28:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RX5nd2QMT0G5GgqbG5b18g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:28:28 INFO - Downloaded 11132001 bytes. 08:28:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 08:28:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:28:28 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 08:28:29 INFO - Return code: 0 08:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:29 INFO - https://queue.taskcluster.net/v1/task/RX5nd2QMT0G5GgqbG5b18g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:28:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RX5nd2QMT0G5GgqbG5b18g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:28:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RX5nd2QMT0G5GgqbG5b18g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:28:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RX5nd2QMT0G5GgqbG5b18g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:28:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RX5nd2QMT0G5GgqbG5b18g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:28:30 INFO - Downloaded 57674967 bytes. 08:28:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RX5nd2QMT0G5GgqbG5b18g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:28:30 INFO - mkdir: /builds/slave/test/properties 08:28:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:28:30 INFO - Writing to file /builds/slave/test/properties/build_url 08:28:30 INFO - Contents: 08:28:30 INFO - build_url:https://queue.taskcluster.net/v1/task/RX5nd2QMT0G5GgqbG5b18g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:28:30 INFO - Running post-action listener: _resource_record_post_action 08:28:30 INFO - Running post-action listener: set_extra_try_arguments 08:28:30 INFO - ##### 08:28:30 INFO - ##### Running populate-webroot step. 08:28:30 INFO - ##### 08:28:30 INFO - Running pre-action listener: _resource_record_pre_action 08:28:30 INFO - Running main action method: populate_webroot 08:28:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:28:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:28:30 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 08:28:30 INFO - '../fennec_ids.txt'], 08:28:30 INFO - 'tests': ['tcheck2']}, 08:28:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:28:30 INFO - '--tppagecycles', 08:28:30 INFO - '7'], 08:28:30 INFO - 'tests': ['tsvgm']}}, 08:28:30 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:28:30 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:28:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:28:30 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:28:30 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:28:30 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:28:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:28:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:30 INFO - 'talos_options': ['--e10s'], 08:28:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:28:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:30 INFO - 'tests': ['damp', 'tps']}, 08:28:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:30 INFO - 'talos_options': ['--e10s'], 08:28:30 INFO - 'tests': ['damp', 'tps']}, 08:28:30 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:28:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:28:30 INFO - 'other': {'tests': ['a11yr', 08:28:30 INFO - 'ts_paint', 08:28:30 INFO - 'tpaint', 08:28:30 INFO - 'sessionrestore', 08:28:30 INFO - 'sessionrestore_no_auto_restore']}, 08:28:30 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:28:30 INFO - 'tests': ['a11yr', 08:28:30 INFO - 'ts_paint', 08:28:30 INFO - 'tpaint', 08:28:30 INFO - 'sessionrestore', 08:28:30 INFO - 'sessionrestore_no_auto_restore']}, 08:28:30 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:28:30 INFO - 'tests': ['a11yr', 08:28:30 INFO - 'ts_paint', 08:28:30 INFO - 'tpaint', 08:28:30 INFO - 'sessionrestore', 08:28:30 INFO - 'sessionrestore_no_auto_restore']}, 08:28:30 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:28:30 INFO - 'tests': ['a11yr', 08:28:30 INFO - 'ts_paint', 08:28:30 INFO - 'tpaint', 08:28:30 INFO - 'sessionrestore', 08:28:30 INFO - 'sessionrestore_no_auto_restore']}, 08:28:30 INFO - 'other_l64': {'tests': ['a11yr', 08:28:30 INFO - 'ts_paint', 08:28:30 INFO - 'tpaint', 08:28:30 INFO - 'sessionrestore', 08:28:30 INFO - 'sessionrestore_no_auto_restore']}, 08:28:30 INFO - 'other_nol64': {'tests': ['a11yr', 08:28:30 INFO - 'ts_paint', 08:28:30 INFO - 'tpaint', 08:28:30 INFO - 'sessionrestore', 08:28:30 INFO - 'sessionrestore_no_auto_restore']}, 08:28:30 INFO - 'svgr': {'tests': ['tsvgx', 08:28:30 INFO - 'tsvgr_opacity', 08:28:30 INFO - 'tart', 08:28:30 INFO - 'tscrollx', 08:28:30 INFO - 'cart']}, 08:28:30 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:28:30 INFO - 'tests': ['tsvgx', 08:28:30 INFO - 'tsvgr_opacity', 08:28:30 INFO - 'tart', 08:28:30 INFO - 'tscrollx', 08:28:30 INFO - 'cart']}, 08:28:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:30 INFO - 'tests': ['tp5o']}, 08:28:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:30 INFO - 'talos_options': ['--e10s'], 08:28:30 INFO - 'tests': ['tp5o']}, 08:28:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:30 INFO - 'talos_options': ['--xperf_path', 08:28:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:28:30 INFO - 'tests': ['tp5n']}, 08:28:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:30 INFO - 'talos_options': ['--e10s', 08:28:30 INFO - '--xperf_path', 08:28:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:28:30 INFO - 'tests': ['tp5n']}}, 08:28:30 INFO - 'talos.zip': {'path': '', 08:28:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:28:30 INFO - Running post-action listener: _resource_record_post_action 08:28:30 INFO - ##### 08:28:30 INFO - ##### Running create-virtualenv step. 08:28:30 INFO - ##### 08:28:30 INFO - Running pre-action listener: _resource_record_pre_action 08:28:30 INFO - Running main action method: create_virtualenv 08:28:30 INFO - Creating virtualenv /builds/slave/test/build/venv 08:28:30 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 08:28:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:28:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:28:30 INFO - Using real prefix '/usr' 08:28:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:28:31 INFO - Installing distribute.............................................................................................................................................................................................done. 08:28:33 INFO - Installing pip.................done. 08:28:33 INFO - Return code: 0 08:28:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:28: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')]} 08:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28: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')]} 08:28:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f9f14a6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1478240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15070b0>, '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 0x1507fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1508440>, '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': '7d909545e45784438f4e8e36000001b3-1449073098.408375-644269301', '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 08:28:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 08:28:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 08:28:33 INFO - Using env: {'DISPLAY': ':0', 08:28:33 INFO - 'HOME': '/home/cltbld', 08:28:33 INFO - 'LANG': 'en_US.UTF-8', 08:28:33 INFO - 'LANGUAGE': 'en_US:en', 08:28:33 INFO - 'LOGNAME': 'cltbld', 08:28:33 INFO - 'MAIL': '/var/mail/cltbld', 08:28:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:33 INFO - 'MOZ_NO_REMOTE': '1', 08:28:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:33 INFO - 'NO_EM_RESTART': '1', 08:28:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:33 INFO - 'PWD': '/builds/slave/test', 08:28:33 INFO - 'SHELL': '/bin/bash', 08:28:33 INFO - 'SHLVL': '1', 08:28:33 INFO - 'TERM': 'linux', 08:28:33 INFO - 'TMOUT': '86400', 08:28:33 INFO - 'USER': 'cltbld', 08:28:33 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449073098.408375-644269301', 08:28:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:33 INFO - '_': '/tools/buildbot/bin/python'} 08:28:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:33 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 08:28:33 INFO - Cleaning up... 08:28:33 INFO - Return code: 0 08:28:33 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:28: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')]} 08:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28: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')]} 08:28:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f14a6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1478240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15070b0>, '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 0x1507fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1508440>, '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': '7d909545e45784438f4e8e36000001b3-1449073098.408375-644269301', '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 08:28:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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>=0.7.1'] in /builds/slave/test/build 08:28:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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>=0.7.1 08:28:33 INFO - Using env: {'DISPLAY': ':0', 08:28:33 INFO - 'HOME': '/home/cltbld', 08:28:33 INFO - 'LANG': 'en_US.UTF-8', 08:28:33 INFO - 'LANGUAGE': 'en_US:en', 08:28:33 INFO - 'LOGNAME': 'cltbld', 08:28:33 INFO - 'MAIL': '/var/mail/cltbld', 08:28:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:33 INFO - 'MOZ_NO_REMOTE': '1', 08:28:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:33 INFO - 'NO_EM_RESTART': '1', 08:28:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:33 INFO - 'PWD': '/builds/slave/test', 08:28:33 INFO - 'SHELL': '/bin/bash', 08:28:33 INFO - 'SHLVL': '1', 08:28:33 INFO - 'TERM': 'linux', 08:28:33 INFO - 'TMOUT': '86400', 08:28:33 INFO - 'USER': 'cltbld', 08:28:33 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449073098.408375-644269301', 08:28:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:33 INFO - '_': '/tools/buildbot/bin/python'} 08:28:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:33 INFO - Downloading/unpacking psutil>=0.7.1 08:28:33 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 08:28:33 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 08:28:33 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 08:28:33 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 08:28:33 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 08:28:33 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 08:28:35 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:28:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:28:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:28:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:28:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:28:35 INFO - Installing collected packages: psutil 08:28:35 INFO - Running setup.py install for psutil 08:28:35 INFO - building 'psutil._psutil_linux' extension 08:28:35 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 08:28:36 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 08:28:36 INFO - building 'psutil._psutil_posix' extension 08:28:36 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 08:28:36 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 08:28:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:28:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:28:37 INFO - Successfully installed psutil 08:28:37 INFO - Cleaning up... 08:28:37 INFO - Return code: 0 08:28:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:28:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f14a6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1478240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15070b0>, '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 0x1507fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1508440>, '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': '7d909545e45784438f4e8e36000001b3-1449073098.408375-644269301', '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 08:28:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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.0.0'] in /builds/slave/test/build 08:28:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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.0.0 08:28:37 INFO - Using env: {'DISPLAY': ':0', 08:28:37 INFO - 'HOME': '/home/cltbld', 08:28:37 INFO - 'LANG': 'en_US.UTF-8', 08:28:37 INFO - 'LANGUAGE': 'en_US:en', 08:28:37 INFO - 'LOGNAME': 'cltbld', 08:28:37 INFO - 'MAIL': '/var/mail/cltbld', 08:28:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:37 INFO - 'MOZ_NO_REMOTE': '1', 08:28:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:37 INFO - 'NO_EM_RESTART': '1', 08:28:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:37 INFO - 'PWD': '/builds/slave/test', 08:28:37 INFO - 'SHELL': '/bin/bash', 08:28:37 INFO - 'SHLVL': '1', 08:28:37 INFO - 'TERM': 'linux', 08:28:37 INFO - 'TMOUT': '86400', 08:28:37 INFO - 'USER': 'cltbld', 08:28:37 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449073098.408375-644269301', 08:28:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:37 INFO - '_': '/tools/buildbot/bin/python'} 08:28:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:28:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:28:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:28:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:28:38 INFO - Installing collected packages: mozsystemmonitor 08:28:38 INFO - Running setup.py install for mozsystemmonitor 08:28:39 INFO - Successfully installed mozsystemmonitor 08:28:39 INFO - Cleaning up... 08:28:39 INFO - Return code: 0 08:28:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:28:39 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')]} 08:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:39 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')]} 08:28:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f9f14a6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1478240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15070b0>, '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 0x1507fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1508440>, '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': '7d909545e45784438f4e8e36000001b3-1449073098.408375-644269301', '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 08:28:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 08:28:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 08:28:39 INFO - Using env: {'DISPLAY': ':0', 08:28:39 INFO - 'HOME': '/home/cltbld', 08:28:39 INFO - 'LANG': 'en_US.UTF-8', 08:28:39 INFO - 'LANGUAGE': 'en_US:en', 08:28:39 INFO - 'LOGNAME': 'cltbld', 08:28:39 INFO - 'MAIL': '/var/mail/cltbld', 08:28:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:39 INFO - 'MOZ_NO_REMOTE': '1', 08:28:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:39 INFO - 'NO_EM_RESTART': '1', 08:28:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:39 INFO - 'PWD': '/builds/slave/test', 08:28:39 INFO - 'SHELL': '/bin/bash', 08:28:39 INFO - 'SHLVL': '1', 08:28:39 INFO - 'TERM': 'linux', 08:28:39 INFO - 'TMOUT': '86400', 08:28:39 INFO - 'USER': 'cltbld', 08:28:39 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449073098.408375-644269301', 08:28:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:39 INFO - '_': '/tools/buildbot/bin/python'} 08:28:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:39 INFO - Downloading/unpacking blobuploader==1.2.4 08:28:39 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 08:28:39 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 08:28:39 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 08:28:39 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 08:28:39 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 08:28:39 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 08:28:40 INFO - Downloading blobuploader-1.2.4.tar.gz 08:28:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:28:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:28:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:28:41 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 08:28:41 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 08:28:41 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 08:28:41 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 08:28:41 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 08:28:41 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 08:28:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:28:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:28:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:28:41 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 08:28:41 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 08:28:41 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 08:28:41 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 08:28:41 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 08:28:41 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 08:28:41 INFO - Downloading docopt-0.6.1.tar.gz 08:28:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:28:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:28:41 INFO - Installing collected packages: blobuploader, requests, docopt 08:28:41 INFO - Running setup.py install for blobuploader 08:28:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:28:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:28:41 INFO - Running setup.py install for requests 08:28:42 INFO - Running setup.py install for docopt 08:28:42 INFO - Successfully installed blobuploader requests docopt 08:28:42 INFO - Cleaning up... 08:28:42 INFO - Return code: 0 08:28:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:28:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f9f14a6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1478240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15070b0>, '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 0x1507fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1508440>, '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': '7d909545e45784438f4e8e36000001b3-1449073098.408375-644269301', '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 08:28:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 08:28:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 08:28:42 INFO - Using env: {'DISPLAY': ':0', 08:28:42 INFO - 'HOME': '/home/cltbld', 08:28:42 INFO - 'LANG': 'en_US.UTF-8', 08:28:42 INFO - 'LANGUAGE': 'en_US:en', 08:28:42 INFO - 'LOGNAME': 'cltbld', 08:28:42 INFO - 'MAIL': '/var/mail/cltbld', 08:28:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:42 INFO - 'MOZ_NO_REMOTE': '1', 08:28:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:42 INFO - 'NO_EM_RESTART': '1', 08:28:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:42 INFO - 'PWD': '/builds/slave/test', 08:28:42 INFO - 'SHELL': '/bin/bash', 08:28:42 INFO - 'SHLVL': '1', 08:28:42 INFO - 'TERM': 'linux', 08:28:42 INFO - 'TMOUT': '86400', 08:28:42 INFO - 'USER': 'cltbld', 08:28:42 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449073098.408375-644269301', 08:28:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:42 INFO - '_': '/tools/buildbot/bin/python'} 08:28:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:28:42 INFO - Running setup.py (path:/tmp/pip-gzT_KY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:28:42 INFO - Running setup.py (path:/tmp/pip-7yzxdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:28:42 INFO - Running setup.py (path:/tmp/pip-wuBJee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:28:42 INFO - Running setup.py (path:/tmp/pip-36wm9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:28:42 INFO - Running setup.py (path:/tmp/pip-_VCB_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:28:42 INFO - Running setup.py (path:/tmp/pip-P155NZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:28:42 INFO - Running setup.py (path:/tmp/pip-JVn2d9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:28:43 INFO - Running setup.py (path:/tmp/pip-lDitIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:28:43 INFO - Running setup.py (path:/tmp/pip-mM2Gtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:28:43 INFO - Running setup.py (path:/tmp/pip-_NtkdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:28:43 INFO - Running setup.py (path:/tmp/pip-tBLkiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:28:43 INFO - Running setup.py (path:/tmp/pip-fkgFfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:28:43 INFO - Running setup.py (path:/tmp/pip-2W74IL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:28:43 INFO - Running setup.py (path:/tmp/pip-s_YcIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:28:43 INFO - Running setup.py (path:/tmp/pip-UbjdAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:28:43 INFO - Running setup.py (path:/tmp/pip-Ke654V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:28:43 INFO - Running setup.py (path:/tmp/pip-G871Y0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:28:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:28:43 INFO - Running setup.py install for manifestparser 08:28:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:28:43 INFO - Running setup.py install for mozcrash 08:28:43 INFO - Running setup.py install for mozdebug 08:28:44 INFO - Running setup.py install for mozdevice 08:28:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:28:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:28:44 INFO - Running setup.py install for mozfile 08:28:44 INFO - Running setup.py install for mozhttpd 08:28:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:28:44 INFO - Running setup.py install for mozinfo 08:28:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:28:44 INFO - Running setup.py install for mozInstall 08:28:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:28:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:28:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:28:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:28:44 INFO - Running setup.py install for mozleak 08:28:44 INFO - Running setup.py install for mozlog 08:28:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:28:44 INFO - Running setup.py install for moznetwork 08:28:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:28:44 INFO - Running setup.py install for mozprocess 08:28:44 INFO - Running setup.py install for mozprofile 08:28:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:28:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:28:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:28:45 INFO - Running setup.py install for mozrunner 08:28:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:28:45 INFO - Running setup.py install for mozscreenshot 08:28:45 INFO - Running setup.py install for moztest 08:28:45 INFO - Running setup.py install for mozversion 08:28:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:28:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:28:45 INFO - Cleaning up... 08:28:45 INFO - Return code: 0 08:28:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:28: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')]} 08:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28: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')]} 08:28:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f9f14a6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1478240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15070b0>, '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 0x1507fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1508440>, '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': '7d909545e45784438f4e8e36000001b3-1449073098.408375-644269301', '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 08:28:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 08:28:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 08:28:45 INFO - Using env: {'DISPLAY': ':0', 08:28:45 INFO - 'HOME': '/home/cltbld', 08:28:45 INFO - 'LANG': 'en_US.UTF-8', 08:28:45 INFO - 'LANGUAGE': 'en_US:en', 08:28:45 INFO - 'LOGNAME': 'cltbld', 08:28:45 INFO - 'MAIL': '/var/mail/cltbld', 08:28:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:45 INFO - 'MOZ_NO_REMOTE': '1', 08:28:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:45 INFO - 'NO_EM_RESTART': '1', 08:28:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:45 INFO - 'PWD': '/builds/slave/test', 08:28:45 INFO - 'SHELL': '/bin/bash', 08:28:45 INFO - 'SHLVL': '1', 08:28:45 INFO - 'TERM': 'linux', 08:28:45 INFO - 'TMOUT': '86400', 08:28:45 INFO - 'USER': 'cltbld', 08:28:45 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449073098.408375-644269301', 08:28:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:45 INFO - '_': '/tools/buildbot/bin/python'} 08:28:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:28:45 INFO - Running setup.py (path:/tmp/pip-MGdGkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:28:45 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)) 08:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:28:45 INFO - Running setup.py (path:/tmp/pip-N6kyTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 08:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:28:45 INFO - Running setup.py (path:/tmp/pip-W4ux6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:28:45 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)) 08:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:28:45 INFO - Running setup.py (path:/tmp/pip-bmPiVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:28:46 INFO - Running setup.py (path:/tmp/pip-WFeIBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:28:46 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)) 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:28:46 INFO - Running setup.py (path:/tmp/pip-j2DWPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:28:46 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)) 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:28:46 INFO - Running setup.py (path:/tmp/pip-P0uLMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:28:46 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)) 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:28:46 INFO - Running setup.py (path:/tmp/pip-4M7GBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:28:46 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)) 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:28:46 INFO - Running setup.py (path:/tmp/pip-kg8cWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:28:46 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)) 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:28:46 INFO - Running setup.py (path:/tmp/pip-mPt1Th-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:28:46 INFO - Running setup.py (path:/tmp/pip-yVoNaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:28:46 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)) 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:28:46 INFO - Running setup.py (path:/tmp/pip-ix6mAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:28:46 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)) 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:28:46 INFO - Running setup.py (path:/tmp/pip-0LS3JQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:28:46 INFO - Running setup.py (path:/tmp/pip-JVPHle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:28:46 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)) 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:28:46 INFO - Running setup.py (path:/tmp/pip-fTvpvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:28:46 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)) 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:28:46 INFO - Running setup.py (path:/tmp/pip-jSrTu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:28:46 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)) 08:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:28:46 INFO - Running setup.py (path:/tmp/pip-7AAv9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:28:46 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)) 08:28:46 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:28:46 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:28:46 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)) 08:28:46 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:28:46 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:28:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:28:46 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 08:28:46 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 08:28:46 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 08:28:46 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 08:28:46 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 08:28:46 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 08:28:48 INFO - Downloading blessings-1.5.1.tar.gz 08:28:48 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 08:28:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:28:48 INFO - Installing collected packages: blessings 08:28:48 INFO - Running setup.py install for blessings 08:28:48 INFO - Successfully installed blessings 08:28:48 INFO - Cleaning up... 08:28:48 INFO - Return code: 0 08:28:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:28:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:28:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:28:49 INFO - Reading from file tmpfile_stdout 08:28:49 INFO - Current package versions: 08:28:49 INFO - argparse == 1.2.1 08:28:49 INFO - blessings == 1.5.1 08:28:49 INFO - blobuploader == 1.2.4 08:28:49 INFO - docopt == 0.6.1 08:28:49 INFO - manifestparser == 1.1 08:28:49 INFO - mozInstall == 1.12 08:28:49 INFO - mozcrash == 0.16 08:28:49 INFO - mozdebug == 0.1 08:28:49 INFO - mozdevice == 0.47 08:28:49 INFO - mozfile == 1.2 08:28:49 INFO - mozhttpd == 0.7 08:28:49 INFO - mozinfo == 0.9 08:28:49 INFO - mozleak == 0.1 08:28:49 INFO - mozlog == 3.1 08:28:49 INFO - moznetwork == 0.27 08:28:49 INFO - mozprocess == 0.22 08:28:49 INFO - mozprofile == 0.27 08:28:49 INFO - mozrunner == 6.11 08:28:49 INFO - mozscreenshot == 0.1 08:28:49 INFO - mozsystemmonitor == 0.0 08:28:49 INFO - moztest == 0.7 08:28:49 INFO - mozversion == 1.4 08:28:49 INFO - psutil == 3.1.1 08:28:49 INFO - requests == 1.2.3 08:28:49 INFO - wsgiref == 0.1.2 08:28:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:28:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f9f14a6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1478240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15070b0>, '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 0x1507fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1508440>, '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': '7d909545e45784438f4e8e36000001b3-1449073098.408375-644269301', '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 08:28:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 08:28:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 08:28:49 INFO - Using env: {'DISPLAY': ':0', 08:28:49 INFO - 'HOME': '/home/cltbld', 08:28:49 INFO - 'LANG': 'en_US.UTF-8', 08:28:49 INFO - 'LANGUAGE': 'en_US:en', 08:28:49 INFO - 'LOGNAME': 'cltbld', 08:28:49 INFO - 'MAIL': '/var/mail/cltbld', 08:28:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:49 INFO - 'MOZ_NO_REMOTE': '1', 08:28:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:49 INFO - 'NO_EM_RESTART': '1', 08:28:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:49 INFO - 'PWD': '/builds/slave/test', 08:28:49 INFO - 'SHELL': '/bin/bash', 08:28:49 INFO - 'SHLVL': '1', 08:28:49 INFO - 'TERM': 'linux', 08:28:49 INFO - 'TMOUT': '86400', 08:28:49 INFO - 'USER': 'cltbld', 08:28:49 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449073098.408375-644269301', 08:28:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:49 INFO - '_': '/tools/buildbot/bin/python'} 08:28:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:49 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 1)) 08:28:49 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 2)) 08:28:49 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 3)) 08:28:49 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 4)) 08:28:49 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 5)) 08:28:49 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 6)) 08:28:49 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 7)) 08:28:49 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 8)) 08:28:49 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:28:49 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 3)) 08:28:49 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:28:49 INFO - Cleaning up... 08:28:49 INFO - Return code: 0 08:28:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:28:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f9f14a6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1478240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15070b0>, '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 0x1507fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1508440>, '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': '7d909545e45784438f4e8e36000001b3-1449073098.408375-644269301', '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 08:28:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 08:28:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 08:28:49 INFO - Using env: {'DISPLAY': ':0', 08:28:49 INFO - 'HOME': '/home/cltbld', 08:28:49 INFO - 'LANG': 'en_US.UTF-8', 08:28:49 INFO - 'LANGUAGE': 'en_US:en', 08:28:49 INFO - 'LOGNAME': 'cltbld', 08:28:49 INFO - 'MAIL': '/var/mail/cltbld', 08:28:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:49 INFO - 'MOZ_NO_REMOTE': '1', 08:28:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:49 INFO - 'NO_EM_RESTART': '1', 08:28:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:49 INFO - 'PWD': '/builds/slave/test', 08:28:49 INFO - 'SHELL': '/bin/bash', 08:28:49 INFO - 'SHLVL': '1', 08:28:49 INFO - 'TERM': 'linux', 08:28:49 INFO - 'TMOUT': '86400', 08:28:49 INFO - 'USER': 'cltbld', 08:28:49 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449073098.408375-644269301', 08:28:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:49 INFO - '_': '/tools/buildbot/bin/python'} 08:28:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:49 INFO - Downloading/unpacking jsonschema 08:28:49 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 08:28:49 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 08:28:49 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 08:28:49 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 08:28:49 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 08:28:49 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 08:28:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:28:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 08:28:51 INFO - Downloading/unpacking functools32 (from jsonschema) 08:28:51 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 08:28:51 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 08:28:51 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 08:28:51 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 08:28:51 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 08:28:51 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 08:28:51 INFO - Downloading functools32-3.2.3-2.tar.gz 08:28:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 08:28:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:28:51 INFO - warning: no files found matching '*.txt' 08:28:51 INFO - no previously-included directories found matching 'build' 08:28:51 INFO - no previously-included directories found matching 'dist' 08:28:51 INFO - no previously-included directories found matching '.git*' 08:28:51 INFO - Installing collected packages: jsonschema, functools32 08:28:51 INFO - Running setup.py install for functools32 08:28:51 INFO - warning: no files found matching '*.txt' 08:28:51 INFO - no previously-included directories found matching 'build' 08:28:51 INFO - no previously-included directories found matching 'dist' 08:28:51 INFO - no previously-included directories found matching '.git*' 08:28:51 INFO - Successfully installed jsonschema functools32 08:28:51 INFO - Cleaning up... 08:28:51 INFO - Return code: 0 08:28:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:28:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f9f14a6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1478240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15070b0>, '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 0x1507fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1508440>, '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': '7d909545e45784438f4e8e36000001b3-1449073098.408375-644269301', '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 08:28:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 08:28:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 08:28:51 INFO - Using env: {'DISPLAY': ':0', 08:28:51 INFO - 'HOME': '/home/cltbld', 08:28:51 INFO - 'LANG': 'en_US.UTF-8', 08:28:51 INFO - 'LANGUAGE': 'en_US:en', 08:28:51 INFO - 'LOGNAME': 'cltbld', 08:28:51 INFO - 'MAIL': '/var/mail/cltbld', 08:28:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:51 INFO - 'MOZ_NO_REMOTE': '1', 08:28:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:51 INFO - 'NO_EM_RESTART': '1', 08:28:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:51 INFO - 'PWD': '/builds/slave/test', 08:28:51 INFO - 'SHELL': '/bin/bash', 08:28:51 INFO - 'SHLVL': '1', 08:28:51 INFO - 'TERM': 'linux', 08:28:51 INFO - 'TMOUT': '86400', 08:28:51 INFO - 'USER': 'cltbld', 08:28:51 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449073098.408375-644269301', 08:28:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:51 INFO - '_': '/tools/buildbot/bin/python'} 08:28:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:52 INFO - Downloading/unpacking flake8 08:28: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 08:28: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 08:28: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 08:28: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 08:28: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 08:28: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 08:28:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:28:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 08:28:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:28: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 08:28: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 08:28: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 08:28: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 08:28: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 08:28: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 08:28:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:28:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 08:28:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:28: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 08:28: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 08:28: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 08:28: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 08:28: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 08:28: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 08:28:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 08:28:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:28: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 08:28: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 08:28: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 08:28: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 08:28: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 08:28: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 08:28:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:28:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:28:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:28:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:28:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:28:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:28:54 INFO - no previously-included directories found matching 'docs/_build' 08:28:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:28:54 INFO - Running setup.py install for pep8 08:28:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:28:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:28:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:28:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:28:54 INFO - no previously-included directories found matching 'docs/_build' 08:28:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:28:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:28:54 INFO - Cleaning up... 08:28:54 INFO - Return code: 0 08:28:54 INFO - Running post-action listener: _resource_record_post_action 08:28:54 INFO - Running post-action listener: _start_resource_monitoring 08:28:54 INFO - Starting resource monitoring. 08:28:54 INFO - ##### 08:28:54 INFO - ##### Running install step. 08:28:54 INFO - ##### 08:28:54 INFO - Running pre-action listener: _resource_record_pre_action 08:28:54 INFO - Running main action method: install 08:28:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:28:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:28:54 INFO - Reading from file tmpfile_stdout 08:28:54 INFO - Detecting whether we're running mozinstall >=1.0... 08:28:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:28:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:28:54 INFO - Reading from file tmpfile_stdout 08:28:54 INFO - Output received: 08:28:54 INFO - Usage: mozinstall [options] installer 08:28:54 INFO - Options: 08:28:54 INFO - -h, --help show this help message and exit 08:28:54 INFO - -d DEST, --destination=DEST 08:28:54 INFO - Directory to install application into. [default: 08:28:54 INFO - "/builds/slave/test"] 08:28:54 INFO - --app=APP Application being installed. [default: firefox] 08:28:54 INFO - mkdir: /builds/slave/test/build/application 08:28:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:28:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:29:09 INFO - Reading from file tmpfile_stdout 08:29:09 INFO - Output received: 08:29:09 INFO - /builds/slave/test/build/application/firefox/firefox 08:29:09 INFO - Running post-action listener: _resource_record_post_action 08:29:09 INFO - ##### 08:29:09 INFO - ##### Running run-tests step. 08:29:09 INFO - ##### 08:29:09 INFO - Running pre-action listener: _resource_record_pre_action 08:29:09 INFO - Running main action method: run_tests 08:29:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:29:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:29:09 INFO - Python 2.7.3 08:29:09 INFO - Return code: 0 08:29:09 INFO - grabbing minidump binary from tooltool 08:29:09 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')]} 08:29:09 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15070b0>, '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 0x1507fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1508440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:29:09 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 08:29:09 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 08:29:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:29:09 INFO - Return code: 0 08:29:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:29:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:29:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:29:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:29:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:29:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:29:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:29:10 INFO - Return code: 0 08:29:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RX5nd2QMT0G5GgqbG5b18g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost'] in /builds/slave/test/build 08:29:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RX5nd2QMT0G5GgqbG5b18g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost 08:29:10 INFO - Using env: {'DISPLAY': ':0', 08:29:10 INFO - 'HOME': '/home/cltbld', 08:29:10 INFO - 'LANG': 'en_US.UTF-8', 08:29:10 INFO - 'LANGUAGE': 'en_US:en', 08:29:10 INFO - 'LOGNAME': 'cltbld', 08:29:10 INFO - 'MAIL': '/var/mail/cltbld', 08:29:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:29:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:29:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:10 INFO - 'MOZ_NO_REMOTE': '1', 08:29:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:29:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:10 INFO - 'NO_EM_RESTART': '1', 08:29:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:10 INFO - 'PWD': '/builds/slave/test', 08:29:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:29:10 INFO - 'SHELL': '/bin/bash', 08:29:10 INFO - 'SHLVL': '1', 08:29:10 INFO - 'TERM': 'linux', 08:29:10 INFO - 'TMOUT': '86400', 08:29:10 INFO - 'USER': 'cltbld', 08:29:10 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1449073098.408375-644269301', 08:29:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:10 INFO - '_': '/tools/buildbot/bin/python'} 08:29:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RX5nd2QMT0G5GgqbG5b18g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost'] with output_timeout 3600 08:29:11 INFO - mozversion INFO | application_buildid: 20151202075221 08:29:11 INFO - mozversion INFO | application_changeset: 2d33fa3346b2e4bfd7720a9f1f19e4a59b84e143 08:29:11 INFO - mozversion INFO | application_display_name: Nightly 08:29:11 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:29:11 INFO - mozversion INFO | application_name: Firefox 08:29:11 INFO - mozversion INFO | application_remotingname: firefox 08:29:11 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 08:29:11 INFO - mozversion INFO | application_vendor: Mozilla 08:29:11 INFO - mozversion INFO | application_version: 45.0a1 08:29:11 INFO - mozversion INFO | platform_buildid: 20151202075221 08:29:11 INFO - mozversion INFO | platform_changeset: 2d33fa3346b2e4bfd7720a9f1f19e4a59b84e143 08:29:11 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 08:29:11 INFO - mozversion INFO | platform_version: 45.0a1 08:29:11 INFO - 2015-12-02 08:29:11,016 DEBUG : using testdate: 1449073751 08:29:11 INFO - 2015-12-02 08:29:11,017 DEBUG : actual date: 1449073751 08:29:11 INFO - 2015-12-02 08:29:11,026 INFO : starting webserver on 'localhost:34739' 08:29:11 INFO - 2015-12-02 08:29:11,027 INFO : Starting test suite talos-linux64-ix-008.e 08:29:11 INFO - 2015-12-02 08:29:11,027 INFO : Starting test dromaeo_css 08:29:11 INFO - 2015-12-02 08:29:11,027 DEBUG : operating with platform_type : linux_ 08:29:11 INFO - 2015-12-02 08:29:11,027 INFO : Initialising browser for dromaeo_css test... 08:29:11 INFO - 2015-12-02 08:29:11,044 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIBJAnT/profile http://localhost:34739/getInfo.html 08:29:16 INFO - 2015-12-02 08:29:16,067 DEBUG : BROWSER_OUTPUT: console.error: 08:29:16 INFO - 2015-12-02 08:29:16,067 DEBUG : BROWSER_OUTPUT: [CustomizableUI] 08:29:16 INFO - 2015-12-02 08:29:16,067 DEBUG : BROWSER_OUTPUT: Custom widget with id loop-button does not return a valid node 08:29:17 INFO - 2015-12-02 08:29:17,232 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:29:17 INFO - 2015-12-02 08:29:17,232 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:29:17 INFO - 2015-12-02 08:29:17,232 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:29:17 INFO - 2015-12-02 08:29:17,232 DEBUG : BROWSER_OUTPUT: __metrics 08:29:17 INFO - 2015-12-02 08:29:17,381 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:29:18 INFO - 2015-12-02 08:29:18,277 INFO : Browser initialized. 08:29:18 INFO - 2015-12-02 08:29:18,278 INFO : Running cycle 1/1 for dromaeo_css test... 08:29:18 INFO - 2015-12-02 08:29:18,278 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIBJAnT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:29:19 INFO - 2015-12-02 08:29:19,972 DEBUG : BROWSER_OUTPUT: console.error: 08:29:19 INFO - 2015-12-02 08:29:19,975 DEBUG : BROWSER_OUTPUT: [CustomizableUI] 08:29:19 INFO - 2015-12-02 08:29:19,975 DEBUG : BROWSER_OUTPUT: Custom widget with id loop-button does not return a valid node 08:29:30 INFO - 2015-12-02 08:29:30,331 DEBUG : BROWSER_OUTPUT: RSS: Main: 143220736 08:29:30 INFO - 2015-12-02 08:29:30,331 DEBUG : BROWSER_OUTPUT: 08:30:19 INFO - 2015-12-02 08:30:19,981 DEBUG : BROWSER_OUTPUT: 1449073819979 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] 08:32:31 INFO - 2015-12-02 08:32:31,572 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34739/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34739/tests/dromaeo/cssquery-ext.html) 08:32:32 INFO - 2015-12-02 08:32:32,589 DEBUG : BROWSER_OUTPUT: RSS: Main: 146501632 08:32:32 INFO - 2015-12-02 08:32:32,589 DEBUG : BROWSER_OUTPUT: 08:35:34 INFO - 2015-12-02 08:35:34,574 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34739/tests/dromaeo/cssquery-ext.html (next: http://localhost:34739/tests/dromaeo/cssquery-jquery.html) 08:35:35 INFO - 2015-12-02 08:35:35,163 DEBUG : BROWSER_OUTPUT: RSS: Main: 144986112 08:35:35 INFO - 2015-12-02 08:35:35,164 DEBUG : BROWSER_OUTPUT: 08:38:36 INFO - 2015-12-02 08:38:36,933 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34739/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34739/tests/dromaeo/cssquery-mootools.html) 08:38:37 INFO - 2015-12-02 08:38:37,522 DEBUG : BROWSER_OUTPUT: RSS: Main: 147075072 08:38:37 INFO - 2015-12-02 08:38:37,523 DEBUG : BROWSER_OUTPUT: 08:41:39 INFO - 2015-12-02 08:41:39,275 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34739/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34739/tests/dromaeo/cssquery-prototype.html) 08:41:39 INFO - 2015-12-02 08:41:39,877 DEBUG : BROWSER_OUTPUT: RSS: Main: 143974400 08:41:39 INFO - 2015-12-02 08:41:39,877 DEBUG : BROWSER_OUTPUT: 08:44:42 INFO - 2015-12-02 08:44:42,531 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34739/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34739/tests/dromaeo/cssquery-yui.html) 08:44:43 INFO - 2015-12-02 08:44:43,157 DEBUG : BROWSER_OUTPUT: RSS: Main: 144928768 08:44:43 INFO - 2015-12-02 08:44:43,157 DEBUG : BROWSER_OUTPUT: 08:47:45 INFO - 2015-12-02 08:47:45,539 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34739/tests/dromaeo/cssquery-yui.html (next: http://localhost:34739/tests/dromaeo/cssquery-dojo.html) 08:47:45 INFO - 2015-12-02 08:47:45,797 DEBUG : BROWSER_OUTPUT: RSS: Main: 147025920 08:47:45 INFO - 2015-12-02 08:47:45,798 DEBUG : BROWSER_OUTPUT: 08:47:45 INFO - 2015-12-02 08:47:45,798 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:47:45 INFO - 2015-12-02 08:47:45,798 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:47:45 INFO - 2015-12-02 08:47:45,798 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:47:45 INFO - 2015-12-02 08:47:45,798 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:47:45 INFO - 2015-12-02 08:47:45,798 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2594.3254753764018;2678.1965410376883;2703.040420650669;2708.282305189124;2722.210558937908;4515.480719717233;4707.058588282344;4708.199606066968;4758.809647614095;4797.160496913035;4626.629869610431;4675.4155730533685;4726.976365118178;4758.904821903559;4767.070421267854;4249.1714115747445;4275.337322714976;4365.061511774968;4381.3647021181905;4388.1223755249075;4186.937195942063;4385;4397.912041759163;4424.80088396023;4483.5516448355065;4283.507396649394;4302.913941721148;4320.827166913351;4326.762028088454;4406.140802543506;4286.721363111388;4294.892627684301;4312.654987601016;4318.265894797861;4321.0709697414895;4108.281050816125;4263.5949584789705;4316.266234740102;4317.76252306123;4354.216241076605;4551.135284295973;4552.772361381918;4698.600618947359;4709.529047095263;4741.668083234175;5031.094403007457;5068.138416469209;5082.2122571001555;5082.720450375265;5125.769340379692;4859.878503037417;5090.9236361454605;5106.361704786902;5116.506599045567;5139.820106296299;4630.953690463086;4659.510751371125;4713.057388522241;4729.385179926657;4781.2111001685025;5231.136862417735;5244.423113457517;5256.737163141827;5264.657797243167;5301.708406037705;4806.543378379049;4914.508549145057;5023.949760502422;5057.72182529957;5057.848264552069;4966.15575352191;5047.217681259411;5048.747562621854;5059.797608095635;5106.055379754683;4887.120318342661;5055.216441451581;5056.115179843513;5059.696418214919;5104.642675012788;4710.317004034396;4834.444038935568;4852.878678033077;4980.601551875841;5014.197728363444;4157.230912281238;4170.22850772608;4180.874573762792;4190.53904070552;4216.852410165629;3639.8857568607973;3647.361711700442;3651.8174091295327;3691.3171063353366;3693.261347730465;4204.222218889515;4360;4362.9781851091175;4370;4383.9342409863875;4959.851204463872;5006.148954677714;5007.223880298559;5051.671641343374;5082.390113186441;4371.082072764755;4371.715838470489;4383;4404.097160082176;4448.1770872388715;4191.266528357525;4364.934525982113;4376.606105450461;4460.1971645104195;4473.217186992263;4809.278608208657;4852.708837469763;4863.465018847854;4864.683795553277;4875.341828853201;5065.645404821627;5092.516210959953;5102.005109003709;5133.56364708989;5147.9227811583605;4596.908061838812;4694.64790140734;4734.668573199843;4802.399700037496;4863.076015557032;4982;4996.750162491933;5059.645824792229;5065;5084.7966081356335;5069.721165335942;5073.949260507347;5112.412072611549;5142.665726727751;5151.716655583829;4724.811007559797;4771.1888978872985;4851.102546028996;4854.296127061486;4900.166971614905;4856.757162141949;4913.434954980223;4919.065377578248;4921.532454416824;4969.130402179677;4632.235681112578;4786.305985631994;4812.133815913029;4840.394950631171;4853.490383509822;4802.27965805132;4840.95159048405;4891.608671306358;4899.779509921991;4931.6301277405055;4769.713817170981;4869.099216644932;4874.366332376769;4877.195262781744;4933.087378834927 08:47:45 INFO - 2015-12-02 08:47:45,799 DEBUG : BROWSER_OUTPUT: |1;ext.html;578.9710514474276;580.0979476913398;581.4040608376414;584.9941500584993;630.2877748144596;35187.82406087969;35825.64174358256;35864.46203306949;35899.461508077366;36042;36999.260014799685;37852.81073594628;37926.8103659482;37986;38063.42904856429;7750.96124519378;7878.25156610124;7895.092064412609;7901.960490197541;7908.881366779503;7621.3521850642765;7717.8070548236465;7734.651940662656;7770.922290777076;7782.64978075988;7756.534607923514;7769.417293702967;7823.413244006694;7826.530408175499;7836.4906281091835;7823.726169584065;7910.3276221520955;7919.683212671515;7920.247576480225;7921.445498815086;7668.731594394225;7783.299503044753;7785.961070194669;7790.649420776079;7791.415643826679;34801;34984;35198.64801352005;35221.82389088038;35254.47118293228;2865.813722108077;2920.620319358491;3023.8034527755844;3229.1927018245437;3294.407006738786;26512.60231096535;27111.45777084467;27223.183304500897;27571.17286481409;27822.026229082087;3179.5230715392645;3189.6650851660474;3232.482802751572;3234.91912702182;3322.9501557476656;199529;201603;201750;201908;202524;45471;46089.30866037012;53220.73389633105;53652.46347536475;53696.463035369925;64987.67506162439;65959;66264.6686766563;66872.66563667248;66953.33046669471;13894.096883702527;14230.928845355707;14315;14347.067440616327;14363.56909292723;10620.575176992834;10710.946445267724;10714.303570267908;10893.07408870255;10920.453977301104;18724.719129213074;18829.34097306588;18841;19010.61978760417;19264.80735192658;7603.923960760321;7809.471612565638;7846.9215307847335;7891.921080789233;7913.564753938589;861.1173547114133;887.8490656588395;889.7508697564692;934.7943452440452;980.666573365045;25114.874425627753;25706.139934790863;26207.868960655076;26313;26578;985.2955137077024;1010.4442556593845;1048.2871647279924;1063.4895250279908;1125.0476610199698;13762.793558096637;13789.448422063206;13854.92176173582;13964.441422343196;14003.439862405594;263032;266331;266623;267685;267897;45194.096118077454;45294.32058519125;45396.773016134706;45493;45519.54480455219;1204.590439250659;1204.6265657645984;1205.9155859089956;1210.279883469352;1229.0474881966368;25060.749392506572;25584.744152558236;25856.482870342865;25975.480490390466;26021.479570408108;39854.80072599618;40184.799076004434;40227.79886100551;40244;40378.97157713125;245044;245815;246443;246970;247401;29315;29748.405031899674;29797.10608681743;29815.956441524442;30409.847950760104;33031.50452743259;33917.49123763195;33963;34288.97133086011;34420.31159376748;28499;28527.857360713064;28785.71214287914;28829.56755648625;29138;28545.143645690663;28667;28832;29279.560806588343;29343;31226.843865780527;32259.51610725794;32417;32489.51265731063;32840.67159328376;26694.733052669224;29267.414651707273;29407.55888661629;29891.701082989763;30013.849930750206;21875.78124218801;21941.561168776854;22080.44798880041;23418.18036368719;24122 08:47:45 INFO - 2015-12-02 08:47:45,799 DEBUG : BROWSER_OUTPUT: |2;jquery.html;333.075714891177;333.2734638488095;334.49658264312205;340.50286581590876;340.6168060931452;15099.320530576122;15229.866464928995;15840.445584404548;16430.178491075458;16585.751213731804;9649.614015439392;9865.901340986587;12713.491460341575;14523.854761452383;14545.709085818276;4455.1089782043555;4576.748278844662;4578.496365399803;4914.97542512287;5078.949210507884;4913.9262911056185;4930.950690493103;4954.3063971044085;4961.6278779091535;4979.377577802775;3312.933741325184;3391.9321613567836;4994.450610432849;5759.884802303952;6413.358664133572;6695.430888374494;6697.397234248892;6711.563748356366;6726.293739157391;6756.12170417845;6286.968565157145;6358.841028974266;6366.267879193906;6375;6406.199225096863;20944.16223351064;20953.68569471459;21083.3674989749;21187.788122118734;21719.13123475075;1948.6589846776758;1989.9303524376721;2025.908834102469;2052.9281475148446;2062.9690554641693;12618.369081545887;13354.86645133546;13776.173429594157;13909.513167039106;14408.207548584824;1742.3988723890238;1808.7739032620923;1858.2009735813594;1876.5777700017522;1921.3851567498407;58534.414655853325;62201.68899155566;63274.0508892367;63568;63704.68147659232;15276.465323713617;15401.152936588594;15411.229438528253;15456.304466299043;15537.30082146306;22736.431589210402;22883.199088031837;22921;22932.770672293063;22939.197128100437;8161.673533058611;8171.346292296602;8204.220599043081;8241.546714930737;8272.255497005299;6368.4586810121655;6431.389018043278;6663.06717059612;6788.219354774165;6815.727370905208;7596.582187979714;7617.314441700273;7784.104827944859;7819.413543984224;7871.527708337518;2940.1767505098605;3027.8637461314293;3031.257341951236;3132.9216769580944;3192.409404260219;372.88813355993096;374.76577139287946;403.4392194849162;408.03703260305656;841.9284360829275;9127.178553930178;9501.42991420517;13543.59369218925;15149;16987.74518382225;845.885805416261;850.2942557677237;856.9143085691381;867.6572753762355;902.5712786426526;8860.246879015227;8895.644174233088;9250.213731832735;9333.533323333806;9394.765130871783;494989;498677;504573;509439;510405;70256.64871675608;70446;72522;72660;74512.25487745162;1039.542601255445;1071.1912506057877;1072.0405237312561;1076.0799516413354;1082.929609575375;14723.33744981457;14736;14898.627534311729;15160.545183644508;15418.841362209523;32932.67067329296;33298.5005224917;33365.33269334551;34458.48312275368;34605.13487162841;43585.34621980736;43703;43913.56086439094;44045.11909761851;44810.327845083004;8594.226519613265;8728.78178045554;8732.956335218283;8796.428232164888;8841.469511829311;9981.900180998387;10146.086852183338;10481.685549433529;16259.51221463358;16374.099424531765;13168.275744833743;13826.516071937434;14068.366923488264;14098.859011409755;14222.786658199928;12979.675508111995;14005.5098071567;14219.502317419254;14303.856961430252;14332.211728355041;14009.789853152415;14389.784153237919;14432.711345773236;14521.709565808836;14765.483208088095;8607.65569377218;8662.177093176138;8751.824963500821;8764.868526971974;8776.122387761172;10784.406857622906;13886.236257005557;13942.860571394156;13972.301384930915;14170.929145354206 08:47:45 INFO - 2015-12-02 08:47:45,802 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1365.1263191557405;1395.4557722488232;1406.5147524104193;1632.4939268826663;1704.974425383619;6279.434850863421;6486.61080335179;7181.892271615923;7412.073490813642;7433.739819106332;6904.930950690492;7131.322524360177;7175.354218120368;7240.96379518103;7241.1672657644385;2017.263698749953;2064.834813214939;2065.535254567725;2067.0491573876034;2067.462459760458;2004.1582535335122;2041.969370459437;2053.1992522916075;2053.3224036068136;2059.866108702937;2070.534129820793;2098.8635738677012;2099.9790002100012;2116.4179850541145;2125.7024016637683;2058.60886431579;2061.8556701030934;2063.7213976113185;2072.885991270487;2074.0459388681224;1754.8508376787988;1757.1741281597629;1778.2975724588714;1803.2967142814314;1804.3684710351404;7258.419326453871;7306.232845551247;7339;7350.63246837656;7382.815429614303;4152.1695660867645;4152.83388664453;4217.662586993033;4219.092895027553;4231.597998190167;2647.139679604117;2689.031948498539;2718.9048383306686;2774.2925553983805;2774.9583756243674;830.3896635972555;847.1063028504925;853.8633818589058;858.3219256787131;861.7285555050139;9696.46669433181;9702.223822094216;9714.077162669535;9734.561944712505;9736.172425343784;3843.557990831034;3850.4801851749653;3871.632194941476;3890.027493126718;3912.6478616924614;8310.750677479686;8374;8385.622646980779;8422.578871056423;8424.452410593292;4231.090315582164;4248.936265956013;4265.91468170641;4269.551697071763;4269.914601707948;3695.5750088740137;3789.1285004448578;3789.7157713171623;3832.5209348831395;3860.7876566789096;3222.8227447490613;3239.5950506186728;3251.5935508061493;3258.7718859679594;3260;920.4753290624413;928.7863791328033;929.0662883801871;936.0732874454242;942.3591957468986;1175.4769127738246;1193.4271549656214;1194.1163538981266;1204.6988252936767;1227.8035514317667;6745.224299205556;6868.244493105754;6869.416099631488;6889.104416425933;6947.687354069079;394.1683048767099;404.9453323801249;406.81286608160576;407.5659422714799;408.90799570097084;5344;5346.064438723286;5383.300170977748;5423.267858839085;5433.728313584305;8440.240378365976;8443.915560844312;8633.309335253165;8653.870191947126;8733.868991965126;8447;8469.3647976402;8477.491350518989;8523.531205783742;8533.701320453754;6565.835854103686;6674.599524028574;6705.932940670628;6717.462602991749;6794.592324460548;6432.839179020562;6453.903191452226;6456.354364563694;6463;6503.739850405931;7508.2867127622785;7624.085109786861;7695.92304076952;7805.063392392949;7813.02337207849;7745.845083098194;7756.634226560953;7758.728444504641;7798.220177982384;8025.478343907627;5297.152455607084;5360.088784906653;5918.556108291981;5935.495482883831;5976.103584462192;6680.265170831108;6836.931630683828;6846.691898864464;6879;6915.343042410963;6461.57999730016;6592.373724496165;6603.504737144637;6643.534952553275;6716.227633821977;6237.750489980532;6274.341194174728;6276.843078923063;6328.525360598066;6363.7772677956045;6573.309802470863;6573.375529324707;6616.8345791355605;6640.468762499085;6671.099401580725;5512.944870551403;5991.041433370814;5993.850153746192;6028.487578555696;6084.787032453843;6173.629582224901;6270.028145637433;6276.811695649138;6282.2147231596055;6282.340354262737 08:47:45 INFO - 2015-12-02 08:47:45,806 DEBUG : BROWSER_OUTPUT: |4;prototype.html;287.53419460474026;294.2247178684168;297.2954098785878;298.75949860362397;304.19692013085444;5510.972445137779;5514.751836167372;5548.056830338842;5587.916181257274;5691.4024027477035;5519.199716041172;5570.192322113301;5588.050031494646;5596.720163991805;5603.187537807015;4108.075682971337;4249.44757181566;4249.532551419341;4253.914921701572;4259.10558782656;4196.895077623053;4227.661787057028;4235.639970602487;4236.364545318196;4251.319788833787;4197.41236226927;4204.11713540157;4205.264078786216;4205.7897105144775;4209.97895010526;4187.623113919732;4198.391233271173;4202.621764041251;4205.705600607944;4223.13425747721;3622.6920711739535;3623.836927338276;3626.746127771057;3632.9273414531563;3677.9448308275396;5124.4106927703415;5131.512506311894;5274.7626356814035;5285.603579731535;5295.920561191585;4762.6904251223905;4817.975910120427;4836.443808961979;4839.419269687624;4847.079054979543;5790.739416726257;5832.154337621064;5857.326407463153;5864.912026319608;5866.413358664142;3884.8057597120032;3963.147923196527;3966.167104907944;3976.08550033491;3983.203359328146;6027.849303767397;6134.9386506134815;6141.201643786324;6143.662098584576;6144.508439324888;4102.528209255974;4103.261412945639;4114.485689288839;4115.588441155861;4116.506019277646;4153.54311025787;4180.832766689359;4189.07840275139;4191.643710284599;4197.118605092965;4813.109574728686;4819.277108433693;4825.30033145192;4827.493113223061;4835.637327200474;5594.440555944373;5746.913796293059;5755.9424405756245;5798.768049278066;5812.476877081083;1453.4694836384645;1454.1493226462426;1455.8689717925438;1455.890808189369;1457.103881113129;963.5230560872413;964.6671898195111;967.260046064761;983.3509883476871;985.935914165577;4994.875128121826;5018.247262910592;5045.899082018339;5070.467600901926;5074.517920797518;6026.969865150646;6040.214772079602;6048.243969503812;6053.606515576562;6081.665508397081;5085.364329458817;5104.2088476286235;5111.616628752784;5115;5127.461616530285;3199.1362332170183;3250.5124231365485;3267.18320419895;3273.3126043530647;3288.391647545212;5721.628094173865;5734.025215713339;5737.79095048401;5738.139279108083;5755.539556835443;6163.137160797492;6283.8114856554375;6291.087792270096;6317.084022816666;6322.9051564226575;5662.980663480613;5669.518090962314;5706.800261990894;5719.771209151588;5741;6067.514598832171;6069.423404776539;6071.7571297147615;6084.60450070744;6087.847803804941;5708.286464191976;5897.056470964625;5923.052311630291;5928.4960778334325;5944.970275148597;5775.942240577709;5783.016887129283;5786.42135786418;5800.651960882361;5813.476787089182;4072.4095006224525;4102.692298077596;4117.155983023533;4118.814653340547;4123.721646289539;5999.160117583455;6135.631862088289;6136.417040381157;6146.846328841636;6146.877062458636;5875.618084824473;5883.058710606282;5893.616914900689;5899.941000589939;5910.143029260647;5879.20630714848;5880.558958078076;5882.647041177543;5889.911651325147;5896.351401345934;5615.943840561706;5712.485876271156;5713.600047996601;5731.484166425042;5766.481016708349;5878;5893.2044174035955;5915.585908986502;5933.6439813609595;5939.198208241832;5616.522595579421;5663.5469162467725;5725.914111288417;5731.828045158652;5738.913916291175 08:47:45 INFO - 2015-12-02 08:47:45,806 DEBUG : BROWSER_OUTPUT: |5;yui.html;660.6020146866874;676.0964327017167;701.1516065560668;748.2853874549805;794.8807678848176;11382;11561.942190289048;11736.471858766354;11771.529138834458;11823;13567.660808479768;13611.659708507292;13633.795493067611;13807.585772426843;13859.445622175126;616.4698359410903;627.2660986645612;780.7384526183721;785.7053604898164;806.2824086562964;807.6446363600027;808.1998821167032;808.6037841457702;809.0614886731393;815.09524427885;840.470503582742;849.3969281809923;850.2305413600701;850.3324889961382;854.1117238072397;841.4698739793921;842.9536375499345;845.349081207473;846.4582667093065;846.9872951905726;615.8583525789094;624.4099326136802;625.9123722678829;626.2172284644195;627;11787.705307367298;11921.582744603897;11931.94034029833;11940.343281119534;11945.283283003047;11142.27575207609;11221;11510.59712910044;11519.769604607862;11654.592089276919;9202.263818894473;9450.57472413743;9502.239820814388;9563;9577.329586928918;3131.01373067483;3186.617605887285;3197.344544368399;3211.550382946389;3231.515272709089;42488.150236995396;42898.35652465247;42942;43250.78374608107;43377.13245735068;9047.140521650434;9268;9285.535723213812;9377.624895004259;9485.098915603006;16052;16267.105309208107;16294;16304.347826087062;16341.509754707378;5663.546916246691;5665.830025099253;5715.228444159985;5722.113072473773;5791.160281759121;3622.5109610202285;3626.5829429615933;3658.579263384692;3708.8331025103935;3711.9628803712158;2686.4224191798858;2710.5798601216843;2720.455908818244;2722.2377734234447;2722.441899410616;480.14294484345976;493.622378880157;501.33573015754274;507.0720581336146;514.5497689521668;539.371632048659;599.8230521996022;609.4819403506983;611.865389614293;622.8115920435129;7674.961625191839;7676.654550545239;7704.5476084777765;7784.260495252942;7837.725679601187;533.1230126441981;533.8078291814943;538.2383926743614;621.3817251834363;666.4168852254278;3553.857845686195;3679.466477360821;3707.8331475083687;3769.1707824278615;3812.866549670748;48808.51191488039;49017.75491122593;49243.753781230866;49329.50670493249;50189.74905125524;44843.55156448394;44982.32526512105;45055.77472112684;45472.54527454749;46141.077178456915;41845.58154418478;41878;42098.57901421069;42762;42817.78591107025;7967.28294453502;8049.436539442183;8307.252347288773;8371.497710137412;8561.657533698832;30396.696033039385;30991.69008309888;31143.598538066293;32137.35725285528;32629.510557341186;35763.46354804628;37042.629573704995;39858.800705996284;40176;40217.79891100526;9865.852012219679;10332.431716255678;10344.586216551254;10524.736881577715;10600.681979540626;11088.833667494833;11181.552737890719;11239.438028098399;11268.323900565993;11496.425178741198;10576.471176440993;10680.57277708883;10810.29733067348;11059.944700276446;11077.723056923642;10633.308834925705;10756.085732712807;10885.183611229348;11021.669349919515;11164.497597607964;10091.293609447268;10470.947645261725;10824.783504329711;10884.7278818027;11234.55061797519;9053;9313.627454902;9365.859512107187;9447.574859131493;9938.55276512573;8944.463332200088;9217.815643687223;9231.76920576964;9564.521773911416;9902.504874756378 08:47:45 INFO - 2015-12-02 08:47:45,806 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:47:45 INFO - 2015-12-02 08:47:45,806 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:47:45 INFO - 2015-12-02 08:47:45,806 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,320 08:47:45 INFO - 2015-12-02 08:47:45,806 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:47:45 INFO - 2015-12-02 08:47:45,806 DEBUG : BROWSER_OUTPUT: __startTimestamp1449074865791__endTimestamp 08:47:45 INFO - 2015-12-02 08:47:45,806 DEBUG : BROWSER_OUTPUT: 08:47:45 INFO - 2015-12-02 08:47:45,806 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:47:45 INFO - 2015-12-02 08:47:45,806 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:47:45 INFO - 2015-12-02 08:47:45,806 DEBUG : BROWSER_OUTPUT: 08:47:45 INFO - 2015-12-02 08:47:45,806 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4650.53 Median:4786.31 stddev:498.36 (10.4%) stddev-sans-first:473.07 08:47:45 INFO - 2015-12-02 08:47:45,807 DEBUG : BROWSER_OUTPUT: Values: 2594.3 2678.2 2703.0 2708.3 2722.2 4515.5 4707.1 4708.2 4758.8 4797.2 4626.6 4675.4 4727.0 4758.9 4767.1 4249.2 4275.3 4365.1 4381.4 4388.1 4186.9 4385.0 4397.9 4424.8 4483.6 4283.5 4302.9 4320.8 4326.8 4406.1 4286.7 4294.9 4312.7 4318.3 4321.1 4108.3 4263.6 4316.3 4317.8 4354.2 4551.1 4552.8 4698.6 4709.5 4741.7 5031.1 5068.1 5082.2 5082.7 5125.8 4859.9 5090.9 5106.4 5116.5 5139.8 4631.0 4659.5 4713.1 4729.4 4781.2 5231.1 5244.4 5256.7 5264.7 5301.7 4806.5 4914.5 5023.9 5057.7 5057.8 4966.2 5047.2 5048.7 5059.8 5106.1 4887.1 5055.2 5056.1 5059.7 5104.6 4710.3 4834.4 4852.9 4980.6 5014.2 4157.2 4170.2 4180.9 4190.5 4216.9 3639.9 3647.4 3651.8 3691.3 3693.3 4204.2 4360.0 4363.0 4370.0 4383.9 4959.9 5006.1 5007.2 5051.7 5082.4 4371.1 4371.7 4383.0 4404.1 4448.2 4191.3 4364.9 4376.6 4460.2 4473.2 4809.3 4852.7 4863.5 4864.7 4875.3 5065.6 5092.5 5102.0 5133.6 5147.9 4596.9 4694.6 4734.7 4802.4 4863.1 4982.0 4996.8 5059.6 5065.0 5084.8 5069.7 5073.9 5112.4 5142.7 5151.7 4724.8 4771.2 4851.1 4854.3 4900.2 4856.8 4913.4 4919.1 4921.5 4969.1 4632.2 4786.3 4812.1 4840.4 4853.5 4802.3 4841.0 4891.6 4899.8 4931.6 4769.7 4869.1 4874.4 4877.2 4933.1 08:47:45 INFO - 2015-12-02 08:47:45,807 DEBUG : BROWSER_OUTPUT: 08:47:45 INFO - 2015-12-02 08:47:45,807 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39556.00 Median:17744.35 stddev:62504.34 (352.2%) stddev-sans-first:62611.16 08:47:45 INFO - 2015-12-02 08:47:45,808 DEBUG : BROWSER_OUTPUT: Values: 579.0 580.1 581.4 585.0 630.3 35187.8 35825.6 35864.5 35899.5 36042.0 36999.3 37852.8 37926.8 37986.0 38063.4 7751.0 7878.3 7895.1 7902.0 7908.9 7621.4 7717.8 7734.7 7770.9 7782.6 7756.5 7769.4 7823.4 7826.5 7836.5 7823.7 7910.3 7919.7 7920.2 7921.4 7668.7 7783.3 7786.0 7790.6 7791.4 34801.0 34984.0 35198.6 35221.8 35254.5 2865.8 2920.6 3023.8 3229.2 3294.4 26512.6 27111.5 27223.2 27571.2 27822.0 3179.5 3189.7 3232.5 3234.9 3323.0 199529.0 201603.0 201750.0 201908.0 202524.0 45471.0 46089.3 53220.7 53652.5 53696.5 64987.7 65959.0 66264.7 66872.7 66953.3 13894.1 14230.9 14315.0 14347.1 14363.6 10620.6 10710.9 10714.3 10893.1 10920.5 18724.7 18829.3 18841.0 19010.6 19264.8 7603.9 7809.5 7846.9 7891.9 7913.6 861.1 887.8 889.8 934.8 980.7 25114.9 25706.1 26207.9 26313.0 26578.0 985.3 1010.4 1048.3 1063.5 1125.0 13762.8 13789.4 13854.9 13964.4 14003.4 263032.0 266331.0 266623.0 267685.0 267897.0 45194.1 45294.3 45396.8 45493.0 45519.5 1204.6 1204.6 1205.9 1210.3 1229.0 25060.7 25584.7 25856.5 25975.5 26021.5 39854.8 40184.8 40227.8 40244.0 40379.0 245044.0 245815.0 246443.0 246970.0 247401.0 29315.0 29748.4 29797.1 29816.0 30409.8 33031.5 33917.5 33963.0 34289.0 34420.3 28499.0 28527.9 28785.7 28829.6 29138.0 28545.1 28667.0 28832.0 29279.6 29343.0 31226.8 32259.5 32417.0 32489.5 32840.7 26694.7 29267.4 29407.6 29891.7 30013.8 21875.8 21941.6 22080.4 23418.2 24122.0 08:47:45 INFO - 2015-12-02 08:47:45,808 DEBUG : BROWSER_OUTPUT: 08:47:45 INFO - 2015-12-02 08:47:45,808 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27759.79 Median:34531.81 stddev:82184.94 (238.0%) stddev-sans-first:82389.69 08:47:45 INFO - 2015-12-02 08:47:45,809 DEBUG : BROWSER_OUTPUT: Values: 333.1 333.3 334.5 340.5 340.6 15099.3 15229.9 15840.4 16430.2 16585.8 9649.6 9865.9 12713.5 14523.9 14545.7 4455.1 4576.7 4578.5 4915.0 5078.9 4913.9 4931.0 4954.3 4961.6 4979.4 3312.9 3391.9 4994.5 5759.9 6413.4 6695.4 6697.4 6711.6 6726.3 6756.1 6287.0 6358.8 6366.3 6375.0 6406.2 20944.2 20953.7 21083.4 21187.8 21719.1 1948.7 1989.9 2025.9 2052.9 2063.0 12618.4 13354.9 13776.2 13909.5 14408.2 1742.4 1808.8 1858.2 1876.6 1921.4 58534.4 62201.7 63274.1 63568.0 63704.7 15276.5 15401.2 15411.2 15456.3 15537.3 22736.4 22883.2 22921.0 22932.8 22939.2 8161.7 8171.3 8204.2 8241.5 8272.3 6368.5 6431.4 6663.1 6788.2 6815.7 7596.6 7617.3 7784.1 7819.4 7871.5 2940.2 3027.9 3031.3 3132.9 3192.4 372.9 374.8 403.4 408.0 841.9 9127.2 9501.4 13543.6 15149.0 16987.7 845.9 850.3 856.9 867.7 902.6 8860.2 8895.6 9250.2 9333.5 9394.8 494989.0 498677.0 504573.0 509439.0 510405.0 70256.6 70446.0 72522.0 72660.0 74512.3 1039.5 1071.2 1072.0 1076.1 1082.9 14723.3 14736.0 14898.6 15160.5 15418.8 32932.7 33298.5 33365.3 34458.5 34605.1 43585.3 43703.0 43913.6 44045.1 44810.3 8594.2 8728.8 8733.0 8796.4 8841.5 9981.9 10146.1 10481.7 16259.5 16374.1 13168.3 13826.5 14068.4 14098.9 14222.8 12979.7 14005.5 14219.5 14303.9 14332.2 14009.8 14389.8 14432.7 14521.7 14765.5 8607.7 8662.2 8751.8 8764.9 8776.1 10784.4 13886.2 13942.9 13972.3 14170.9 08:47:45 INFO - 2015-12-02 08:47:45,809 DEBUG : BROWSER_OUTPUT: 08:47:45 INFO - 2015-12-02 08:47:45,809 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4965.25 Median:6278.14 stddev:2634.41 (42.0%) stddev-sans-first:2627.90 08:47:45 INFO - 2015-12-02 08:47:45,811 DEBUG : BROWSER_OUTPUT: Values: 1365.1 1395.5 1406.5 1632.5 1705.0 6279.4 6486.6 7181.9 7412.1 7433.7 6904.9 7131.3 7175.4 7241.0 7241.2 2017.3 2064.8 2065.5 2067.0 2067.5 2004.2 2042.0 2053.2 2053.3 2059.9 2070.5 2098.9 2100.0 2116.4 2125.7 2058.6 2061.9 2063.7 2072.9 2074.0 1754.9 1757.2 1778.3 1803.3 1804.4 7258.4 7306.2 7339.0 7350.6 7382.8 4152.2 4152.8 4217.7 4219.1 4231.6 2647.1 2689.0 2718.9 2774.3 2775.0 830.4 847.1 853.9 858.3 861.7 9696.5 9702.2 9714.1 9734.6 9736.2 3843.6 3850.5 3871.6 3890.0 3912.6 8310.8 8374.0 8385.6 8422.6 8424.5 4231.1 4248.9 4265.9 4269.6 4269.9 3695.6 3789.1 3789.7 3832.5 3860.8 3222.8 3239.6 3251.6 3258.8 3260.0 920.5 928.8 929.1 936.1 942.4 1175.5 1193.4 1194.1 1204.7 1227.8 6745.2 6868.2 6869.4 6889.1 6947.7 394.2 404.9 406.8 407.6 408.9 5344.0 5346.1 5383.3 5423.3 5433.7 8440.2 8443.9 8633.3 8653.9 8733.9 8447.0 8469.4 8477.5 8523.5 8533.7 6565.8 6674.6 6705.9 6717.5 6794.6 6432.8 6453.9 6456.4 6463.0 6503.7 7508.3 7624.1 7695.9 7805.1 7813.0 7745.8 7756.6 7758.7 7798.2 8025.5 5297.2 5360.1 5918.6 5935.5 5976.1 6680.3 6836.9 6846.7 6879.0 6915.3 6461.6 6592.4 6603.5 6643.5 6716.2 6237.8 6274.3 6276.8 6328.5 6363.8 6573.3 6573.4 6616.8 6640.5 6671.1 5512.9 5991.0 5993.9 6028.5 6084.8 6173.6 6270.0 6276.8 6282.2 6282.3 08:47:45 INFO - 2015-12-02 08:47:45,811 DEBUG : BROWSER_OUTPUT: 08:47:45 INFO - 2015-12-02 08:47:45,811 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4817.14 Median:5587.98 stddev:1444.70 (25.9%) stddev-sans-first:1408.18 08:47:45 INFO - 2015-12-02 08:47:45,811 DEBUG : BROWSER_OUTPUT: Values: 287.5 294.2 297.3 298.8 304.2 5511.0 5514.8 5548.1 5587.9 5691.4 5519.2 5570.2 5588.1 5596.7 5603.2 4108.1 4249.4 4249.5 4253.9 4259.1 4196.9 4227.7 4235.6 4236.4 4251.3 4197.4 4204.1 4205.3 4205.8 4210.0 4187.6 4198.4 4202.6 4205.7 4223.1 3622.7 3623.8 3626.7 3632.9 3677.9 5124.4 5131.5 5274.8 5285.6 5295.9 4762.7 4818.0 4836.4 4839.4 4847.1 5790.7 5832.2 5857.3 5864.9 5866.4 3884.8 3963.1 3966.2 3976.1 3983.2 6027.8 6134.9 6141.2 6143.7 6144.5 4102.5 4103.3 4114.5 4115.6 4116.5 4153.5 4180.8 4189.1 4191.6 4197.1 4813.1 4819.3 4825.3 4827.5 4835.6 5594.4 5746.9 5755.9 5798.8 5812.5 1453.5 1454.1 1455.9 1455.9 1457.1 963.5 964.7 967.3 983.4 985.9 4994.9 5018.2 5045.9 5070.5 5074.5 6027.0 6040.2 6048.2 6053.6 6081.7 5085.4 5104.2 5111.6 5115.0 5127.5 3199.1 3250.5 3267.2 3273.3 3288.4 5721.6 5734.0 5737.8 5738.1 5755.5 6163.1 6283.8 6291.1 6317.1 6322.9 5663.0 5669.5 5706.8 5719.8 5741.0 6067.5 6069.4 6071.8 6084.6 6087.8 5708.3 5897.1 5923.1 5928.5 5945.0 5775.9 5783.0 5786.4 5800.7 5813.5 4072.4 4102.7 4117.2 4118.8 4123.7 5999.2 6135.6 6136.4 6146.8 6146.9 5875.6 5883.1 5893.6 5899.9 5910.1 5879.2 5880.6 5882.6 5889.9 5896.4 5615.9 5712.5 5713.6 5731.5 5766.5 5878.0 5893.2 5915.6 5933.6 5939.2 5616.5 5663.5 5725.9 5731.8 5738.9 08:47:45 INFO - 2015-12-02 08:47:45,811 DEBUG : BROWSER_OUTPUT: 08:47:45 INFO - 2015-12-02 08:47:45,811 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12435.08 Median:45019.05 stddev:14028.40 (31.2%) stddev-sans-first:14039.89 08:47:45 INFO - 2015-12-02 08:47:45,812 DEBUG : BROWSER_OUTPUT: Values: 660.6 676.1 701.2 748.3 794.9 11382.0 11561.9 11736.5 11771.5 11823.0 13567.7 13611.7 13633.8 13807.6 13859.4 616.5 627.3 780.7 785.7 806.3 807.6 808.2 808.6 809.1 815.1 840.5 849.4 850.2 850.3 854.1 841.5 843.0 845.3 846.5 847.0 615.9 624.4 625.9 626.2 627.0 11787.7 11921.6 11931.9 11940.3 11945.3 11142.3 11221.0 11510.6 11519.8 11654.6 9202.3 9450.6 9502.2 9563.0 9577.3 3131.0 3186.6 3197.3 3211.6 3231.5 42488.2 42898.4 42942.0 43250.8 43377.1 9047.1 9268.0 9285.5 9377.6 9485.1 16052.0 16267.1 16294.0 16304.3 16341.5 5663.5 5665.8 5715.2 5722.1 5791.2 3622.5 3626.6 3658.6 3708.8 3712.0 2686.4 2710.6 2720.5 2722.2 2722.4 480.1 493.6 501.3 507.1 514.5 539.4 599.8 609.5 611.9 622.8 7675.0 7676.7 7704.5 7784.3 7837.7 533.1 533.8 538.2 621.4 666.4 3553.9 3679.5 3707.8 3769.2 3812.9 48808.5 49017.8 49243.8 49329.5 50189.7 44843.6 44982.3 45055.8 45472.5 46141.1 41845.6 41878.0 42098.6 42762.0 42817.8 7967.3 8049.4 8307.3 8371.5 8561.7 30396.7 30991.7 31143.6 32137.4 32629.5 35763.5 37042.6 39858.8 40176.0 40217.8 9865.9 10332.4 10344.6 10524.7 10600.7 11088.8 11181.6 11239.4 11268.3 11496.4 10576.5 10680.6 10810.3 11059.9 11077.7 10633.3 10756.1 10885.2 11021.7 11164.5 10091.3 10470.9 10824.8 10884.7 11234.6 9053.0 9313.6 9365.9 9447.6 9938.6 8944.5 9217.8 9231.8 9564.5 9902.5 08:47:45 INFO - 2015-12-02 08:47:45,812 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:47:45 INFO - 2015-12-02 08:47:45,812 DEBUG : BROWSER_OUTPUT: 08:47:46 INFO - 2015-12-02 08:47:46,541 INFO : Browser exited with error code: 0 08:47:46 INFO - 2015-12-02 08:47:46,560 INFO : Completed test dromaeo_css (00:18:35) 08:47:46 INFO - 2015-12-02 08:47:46,560 INFO : Starting test kraken 08:47:46 INFO - 2015-12-02 08:47:46,560 DEBUG : operating with platform_type : linux_ 08:47:46 INFO - 2015-12-02 08:47:46,560 INFO : Initialising browser for kraken test... 08:47:46 INFO - 2015-12-02 08:47:46,566 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdzmFGW/profile http://localhost:34739/getInfo.html 08:47:49 INFO - 2015-12-02 08:47:49,997 DEBUG : BROWSER_OUTPUT: console.error: 08:47:49 INFO - 2015-12-02 08:47:49,997 DEBUG : BROWSER_OUTPUT: [CustomizableUI] 08:47:49 INFO - 2015-12-02 08:47:49,997 DEBUG : BROWSER_OUTPUT: Custom widget with id loop-button does not return a valid node 08:47:51 INFO - 2015-12-02 08:47:51,188 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:47:51 INFO - 2015-12-02 08:47:51,188 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:47:51 INFO - 2015-12-02 08:47:51,188 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:47:51 INFO - 2015-12-02 08:47:51,188 DEBUG : BROWSER_OUTPUT: __metrics 08:47:51 INFO - 2015-12-02 08:47:51,330 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:47:52 INFO - 2015-12-02 08:47:52,217 INFO : Browser initialized. 08:47:52 INFO - 2015-12-02 08:47:52,217 INFO : Running cycle 1/1 for kraken test... 08:47:52 INFO - 2015-12-02 08:47:52,218 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdzmFGW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:47:53 INFO - 2015-12-02 08:47:53,858 DEBUG : BROWSER_OUTPUT: console.error: 08:47:53 INFO - 2015-12-02 08:47:53,861 DEBUG : BROWSER_OUTPUT: [CustomizableUI] 08:47:53 INFO - 2015-12-02 08:47:53,861 DEBUG : BROWSER_OUTPUT: Custom widget with id loop-button does not return a valid node 08:48:04 INFO - 2015-12-02 08:48:04,243 DEBUG : BROWSER_OUTPUT: RSS: Main: 142913536 08:48:04 INFO - 2015-12-02 08:48:04,243 DEBUG : BROWSER_OUTPUT: 08:48:06 INFO - 2015-12-02 08:48:06,818 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34739/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34739/tests/kraken/driver.html?testName=audio-beat-detection) 08:48:07 INFO - 2015-12-02 08:48:07,440 DEBUG : BROWSER_OUTPUT: RSS: Main: 144011264 08:48:07 INFO - 2015-12-02 08:48:07,441 DEBUG : BROWSER_OUTPUT: 08:48:10 INFO - 2015-12-02 08:48:10,177 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34739/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34739/tests/kraken/driver.html?testName=audio-dft) 08:48:10 INFO - 2015-12-02 08:48:10,778 DEBUG : BROWSER_OUTPUT: RSS: Main: 144363520 08:48:10 INFO - 2015-12-02 08:48:10,778 DEBUG : BROWSER_OUTPUT: 08:48:13 INFO - 2015-12-02 08:48:13,660 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34739/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34739/tests/kraken/driver.html?testName=audio-fft) 08:48:14 INFO - 2015-12-02 08:48:14,253 DEBUG : BROWSER_OUTPUT: RSS: Main: 138829824 08:48:14 INFO - 2015-12-02 08:48:14,253 DEBUG : BROWSER_OUTPUT: 08:48:16 INFO - 2015-12-02 08:48:16,310 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34739/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34739/tests/kraken/driver.html?testName=audio-oscillator) 08:48:16 INFO - 2015-12-02 08:48:16,898 DEBUG : BROWSER_OUTPUT: RSS: Main: 138924032 08:48:16 INFO - 2015-12-02 08:48:16,898 DEBUG : BROWSER_OUTPUT: 08:48:19 INFO - 2015-12-02 08:48:19,136 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34739/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34739/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:48:19 INFO - 2015-12-02 08:48:19,717 DEBUG : BROWSER_OUTPUT: RSS: Main: 140419072 08:48:19 INFO - 2015-12-02 08:48:19,717 DEBUG : BROWSER_OUTPUT: 08:48:22 INFO - 2015-12-02 08:48:22,796 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34739/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34739/tests/kraken/driver.html?testName=imaging-darkroom) 08:48:23 INFO - 2015-12-02 08:48:23,389 DEBUG : BROWSER_OUTPUT: RSS: Main: 141029376 08:48:23 INFO - 2015-12-02 08:48:23,389 DEBUG : BROWSER_OUTPUT: 08:48:26 INFO - 2015-12-02 08:48:26,870 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34739/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34739/tests/kraken/driver.html?testName=imaging-desaturate) 08:48:27 INFO - 2015-12-02 08:48:27,463 DEBUG : BROWSER_OUTPUT: RSS: Main: 138588160 08:48:27 INFO - 2015-12-02 08:48:27,464 DEBUG : BROWSER_OUTPUT: 08:48:30 INFO - 2015-12-02 08:48:30,366 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34739/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34739/tests/kraken/driver.html?testName=json-parse-financial) 08:48:30 INFO - 2015-12-02 08:48:30,967 DEBUG : BROWSER_OUTPUT: RSS: Main: 139104256 08:48:31 INFO - 2015-12-02 08:48:30,968 DEBUG : BROWSER_OUTPUT: 08:48:32 INFO - 2015-12-02 08:48:32,725 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34739/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34739/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:48:33 INFO - 2015-12-02 08:48:33,314 DEBUG : BROWSER_OUTPUT: RSS: Main: 140890112 08:48:33 INFO - 2015-12-02 08:48:33,314 DEBUG : BROWSER_OUTPUT: 08:48:35 INFO - 2015-12-02 08:48:35,205 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34739/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34739/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:48:35 INFO - 2015-12-02 08:48:35,818 DEBUG : BROWSER_OUTPUT: RSS: Main: 140685312 08:48:35 INFO - 2015-12-02 08:48:35,818 DEBUG : BROWSER_OUTPUT: 08:48:37 INFO - 2015-12-02 08:48:37,931 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34739/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34739/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:48:38 INFO - 2015-12-02 08:48:38,537 DEBUG : BROWSER_OUTPUT: RSS: Main: 141062144 08:48:38 INFO - 2015-12-02 08:48:38,537 DEBUG : BROWSER_OUTPUT: 08:48:41 INFO - 2015-12-02 08:48:41,138 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34739/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34739/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:48:41 INFO - 2015-12-02 08:48:41,745 DEBUG : BROWSER_OUTPUT: RSS: Main: 140877824 08:48:41 INFO - 2015-12-02 08:48:41,745 DEBUG : BROWSER_OUTPUT: 08:48:44 INFO - 2015-12-02 08:48:44,360 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34739/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34739/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:48:44 INFO - 2015-12-02 08:48:44,953 DEBUG : BROWSER_OUTPUT: RSS: Main: 141320192 08:48:44 INFO - 2015-12-02 08:48:44,954 DEBUG : BROWSER_OUTPUT: 08:48:46 INFO - 2015-12-02 08:48:46,735 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34739/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34739/tests/kraken/driver.html?testName=ai-astar) 08:48:46 INFO - 2015-12-02 08:48:46,985 DEBUG : BROWSER_OUTPUT: RSS: Main: 139907072 08:48:46 INFO - 2015-12-02 08:48:46,985 DEBUG : BROWSER_OUTPUT: 08:48:46 INFO - 2015-12-02 08:48:46,986 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:48:46 INFO - 2015-12-02 08:48:46,986 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:48:46 INFO - 2015-12-02 08:48:46,986 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:48:46 INFO - 2015-12-02 08:48:46,987 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:48:46 INFO - 2015-12-02 08:48:46,987 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;106;111;111;112;122;113;110;111;112 08:48:46 INFO - 2015-12-02 08:48:46,987 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;159;140;152;171;130;151;154;148;165;131 08:48:46 INFO - 2015-12-02 08:48:46,987 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;164;162;162;162;166;164;164;162 08:48:46 INFO - 2015-12-02 08:48:46,987 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;72;79;72;136;73;78;71;77 08:48:46 INFO - 2015-12-02 08:48:46,987 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;94;132;93;94;96;131;93;94;132 08:48:46 INFO - 2015-12-02 08:48:46,987 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;110;114;110;112;114;110;109;110;111 08:48:46 INFO - 2015-12-02 08:48:46,987 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;149;148;148;148;149;149;147;147;147 08:48:46 INFO - 2015-12-02 08:48:46,988 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;97;96;96;96;96;96;96;95 08:48:46 INFO - 2015-12-02 08:48:46,988 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;72;72;70;71;72;69;71;70;73 08:48:46 INFO - 2015-12-02 08:48:46,988 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;68;69;68;68;69;69;69;68;69 08:48:46 INFO - 2015-12-02 08:48:46,988 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;90;84;86;85;83;83;84;83;85;85 08:48:46 INFO - 2015-12-02 08:48:46,988 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;134;124;129;122;130;126;134;130;129;131 08:48:46 INFO - 2015-12-02 08:48:46,989 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;146;147;152;147;141;149;159;141;146 08:48:46 INFO - 2015-12-02 08:48:46,989 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;70;71;70;70;69;71;70;69;70 08:48:46 INFO - 2015-12-02 08:48:46,989 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:48:46 INFO - 2015-12-02 08:48:46,989 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:48:46 INFO - 2015-12-02 08:48:46,989 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,798 08:48:46 INFO - 2015-12-02 08:48:46,990 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:48:46 INFO - 2015-12-02 08:48:46,990 DEBUG : BROWSER_OUTPUT: __startTimestamp1449074926985__endTimestamp 08:48:46 INFO - 2015-12-02 08:48:46,990 DEBUG : BROWSER_OUTPUT: 08:48:46 INFO - 2015-12-02 08:48:46,994 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:48:46 INFO - 2015-12-02 08:48:46,994 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:48:46 INFO - 2015-12-02 08:48:46,994 DEBUG : BROWSER_OUTPUT: 08:48:46 INFO - 2015-12-02 08:48:46,994 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.90 Median:111.50 stddev:4.01 (3.6%) stddev-sans-first:4.24 08:48:46 INFO - 2015-12-02 08:48:46,994 DEBUG : BROWSER_OUTPUT: Values: 111.0 106.0 111.0 111.0 112.0 122.0 113.0 110.0 111.0 112.0 08:48:46 INFO - 2015-12-02 08:48:46,994 DEBUG : BROWSER_OUTPUT: 08:48:46 INFO - 2015-12-02 08:48:46,994 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.10 Median:153.00 stddev:13.47 (8.8%) stddev-sans-first:13.90 08:48:46 INFO - 2015-12-02 08:48:46,994 DEBUG : BROWSER_OUTPUT: Values: 159.0 140.0 152.0 171.0 130.0 151.0 154.0 148.0 165.0 131.0 08:48:46 INFO - 2015-12-02 08:48:46,994 DEBUG : BROWSER_OUTPUT: 08:48:46 INFO - 2015-12-02 08:48:46,994 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:1.41 (0.9%) stddev-sans-first:1.45 08:48:46 INFO - 2015-12-02 08:48:46,994 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 164.0 162.0 162.0 162.0 166.0 164.0 164.0 162.0 08:48:46 INFO - 2015-12-02 08:48:46,994 DEBUG : BROWSER_OUTPUT: 08:48:46 INFO - 2015-12-02 08:48:46,995 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.10 Median:72.50 stddev:19.87 (27.4%) stddev-sans-first:20.80 08:48:46 INFO - 2015-12-02 08:48:46,995 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 72.0 79.0 72.0 136.0 73.0 78.0 71.0 77.0 08:48:46 INFO - 2015-12-02 08:48:46,995 DEBUG : BROWSER_OUTPUT: 08:48:46 INFO - 2015-12-02 08:48:46,995 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.50 Median:94.00 stddev:18.09 (19.2%) stddev-sans-first:18.86 08:48:46 INFO - 2015-12-02 08:48:46,995 DEBUG : BROWSER_OUTPUT: Values: 96.0 94.0 132.0 93.0 94.0 96.0 131.0 93.0 94.0 132.0 08:48:46 INFO - 2015-12-02 08:48:46,995 DEBUG : BROWSER_OUTPUT: 08:48:46 INFO - 2015-12-02 08:48:46,995 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:111.10 Median:111.00 stddev:1.73 (1.6%) stddev-sans-first:1.83 08:48:46 INFO - 2015-12-02 08:48:46,995 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 114.0 110.0 112.0 114.0 110.0 109.0 110.0 111.0 08:48:46 INFO - 2015-12-02 08:48:46,995 DEBUG : BROWSER_OUTPUT: 08:48:46 INFO - 2015-12-02 08:48:46,995 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 08:48:46 INFO - 2015-12-02 08:48:46,995 DEBUG : BROWSER_OUTPUT: Values: 148.0 149.0 148.0 148.0 148.0 149.0 149.0 147.0 147.0 147.0 08:48:46 INFO - 2015-12-02 08:48:46,995 DEBUG : BROWSER_OUTPUT: 08:48:46 INFO - 2015-12-02 08:48:46,995 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 08:48:46 INFO - 2015-12-02 08:48:46,995 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 08:48:46 INFO - 2015-12-02 08:48:46,996 DEBUG : BROWSER_OUTPUT: 08:48:46 INFO - 2015-12-02 08:48:46,996 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.20 Median:72.00 stddev:1.23 (1.7%) stddev-sans-first:1.27 08:48:46 INFO - 2015-12-02 08:48:46,996 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 72.0 70.0 71.0 72.0 69.0 71.0 70.0 73.0 08:48:46 INFO - 2015-12-02 08:48:46,996 DEBUG : BROWSER_OUTPUT: 08:48:46 INFO - 2015-12-02 08:48:46,997 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.52 (0.7%) stddev-sans-first:0.53 08:48:46 INFO - 2015-12-02 08:48:46,997 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 69.0 68.0 68.0 69.0 69.0 69.0 68.0 69.0 08:48:46 INFO - 2015-12-02 08:48:46,997 DEBUG : BROWSER_OUTPUT: 08:48:46 INFO - 2015-12-02 08:48:46,997 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:85.00 stddev:2.10 (2.5%) stddev-sans-first:1.09 08:48:46 INFO - 2015-12-02 08:48:46,997 DEBUG : BROWSER_OUTPUT: Values: 90.0 84.0 86.0 85.0 83.0 83.0 84.0 83.0 85.0 85.0 08:48:46 INFO - 2015-12-02 08:48:46,997 DEBUG : BROWSER_OUTPUT: 08:48:46 INFO - 2015-12-02 08:48:46,997 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:128.90 Median:130.00 stddev:3.93 (3.0%) stddev-sans-first:3.71 08:48:46 INFO - 2015-12-02 08:48:46,997 DEBUG : BROWSER_OUTPUT: Values: 134.0 124.0 129.0 122.0 130.0 126.0 134.0 130.0 129.0 131.0 08:48:46 INFO - 2015-12-02 08:48:46,997 DEBUG : BROWSER_OUTPUT: 08:48:46 INFO - 2015-12-02 08:48:46,998 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.50 Median:147.00 stddev:5.21 (3.5%) stddev-sans-first:5.53 08:48:47 INFO - 2015-12-02 08:48:46,998 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 147.0 152.0 147.0 141.0 149.0 159.0 141.0 146.0 08:48:47 INFO - 2015-12-02 08:48:46,998 DEBUG : BROWSER_OUTPUT: 08:48:47 INFO - 2015-12-02 08:48:46,998 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 08:48:47 INFO - 2015-12-02 08:48:46,998 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 71.0 70.0 70.0 69.0 71.0 70.0 69.0 70.0 08:48:47 INFO - 2015-12-02 08:48:46,998 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:48:47 INFO - 2015-12-02 08:48:46,998 DEBUG : BROWSER_OUTPUT: 08:48:47 INFO - 2015-12-02 08:48:47,917 INFO : Browser exited with error code: 0 08:48:47 INFO - 2015-12-02 08:48:47,966 INFO : Completed test kraken (00:01:01) 08:48:47 INFO - 2015-12-02 08:48:47,966 INFO : Starting test v8_7 08:48:47 INFO - 2015-12-02 08:48:47,966 DEBUG : operating with platform_type : linux_ 08:48:47 INFO - 2015-12-02 08:48:47,966 INFO : Initialising browser for v8_7 test... 08:48:47 INFO - 2015-12-02 08:48:47,972 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFkNfC3/profile http://localhost:34739/getInfo.html 08:48:51 INFO - 2015-12-02 08:48:51,443 DEBUG : BROWSER_OUTPUT: console.error: 08:48:51 INFO - 2015-12-02 08:48:51,445 DEBUG : BROWSER_OUTPUT: [CustomizableUI] 08:48:51 INFO - 2015-12-02 08:48:51,445 DEBUG : BROWSER_OUTPUT: Custom widget with id loop-button does not return a valid node 08:48:52 INFO - 2015-12-02 08:48:52,711 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:48:52 INFO - 2015-12-02 08:48:52,711 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:48:52 INFO - 2015-12-02 08:48:52,711 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:48:52 INFO - 2015-12-02 08:48:52,711 DEBUG : BROWSER_OUTPUT: __metrics 08:48:52 INFO - 2015-12-02 08:48:52,852 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:48:53 INFO - 2015-12-02 08:48:53,765 INFO : Browser initialized. 08:48:53 INFO - 2015-12-02 08:48:53,765 INFO : Running cycle 1/1 for v8_7 test... 08:48:53 INFO - 2015-12-02 08:48:53,766 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFkNfC3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:48:55 INFO - 2015-12-02 08:48:55,439 DEBUG : BROWSER_OUTPUT: console.error: 08:48:55 INFO - 2015-12-02 08:48:55,442 DEBUG : BROWSER_OUTPUT: [CustomizableUI] 08:48:55 INFO - 2015-12-02 08:48:55,442 DEBUG : BROWSER_OUTPUT: Custom widget with id loop-button does not return a valid node 08:49:05 INFO - 2015-12-02 08:49:05,808 DEBUG : BROWSER_OUTPUT: RSS: Main: 143388672 08:49:05 INFO - 2015-12-02 08:49:05,808 DEBUG : BROWSER_OUTPUT: 08:49:27 INFO - 2015-12-02 08:49:27,263 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34739/tests/v8_7/run.html (next: http://localhost:34739/tests/v8_7/run.html) 08:49:27 INFO - 2015-12-02 08:49:27,513 DEBUG : BROWSER_OUTPUT: RSS: Main: 138752000 08:49:27 INFO - 2015-12-02 08:49:27,513 DEBUG : BROWSER_OUTPUT: 08:49:27 INFO - 2015-12-02 08:49:27,514 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:49:27 INFO - 2015-12-02 08:49:27,514 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:49:27 INFO - 2015-12-02 08:49:27,514 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:49:27 INFO - 2015-12-02 08:49:27,514 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:49:27 INFO - 2015-12-02 08:49:27,514 DEBUG : BROWSER_OUTPUT: |0;Richards;165.89250165892503 08:49:27 INFO - 2015-12-02 08:49:27,514 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;189.9335232668566 08:49:27 INFO - 2015-12-02 08:49:27,514 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.85495971103086 08:49:27 INFO - 2015-12-02 08:49:27,514 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5218.75 08:49:27 INFO - 2015-12-02 08:49:27,514 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1079.913606911447 08:49:27 INFO - 2015-12-02 08:49:27,514 DEBUG : BROWSER_OUTPUT: |5;Earley;698.8120195667366 08:49:27 INFO - 2015-12-02 08:49:27,514 DEBUG : BROWSER_OUTPUT: |6;Boyer;12132.530120481928 08:49:27 INFO - 2015-12-02 08:49:27,514 DEBUG : BROWSER_OUTPUT: |7;RegExp;25820.51282051282 08:49:27 INFO - 2015-12-02 08:49:27,515 DEBUG : BROWSER_OUTPUT: |8;Splay;595.1393005334915 08:49:27 INFO - 2015-12-02 08:49:27,515 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 08:49:27 INFO - 2015-12-02 08:49:27,515 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:49:27 INFO - 2015-12-02 08:49:27,515 DEBUG : BROWSER_OUTPUT: __startTimestamp1449074967512__endTimestamp 08:49:27 INFO - 2015-12-02 08:49:27,515 DEBUG : BROWSER_OUTPUT: 08:49:27 INFO - 2015-12-02 08:49:27,515 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:49:27 INFO - 2015-12-02 08:49:27,515 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:49:27 INFO - 2015-12-02 08:49:27,516 DEBUG : BROWSER_OUTPUT: 08:49:27 INFO - 2015-12-02 08:49:27,516 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.89 Median:165.89 stddev:0.00 (0.0%) 08:49:27 INFO - 2015-12-02 08:49:27,516 DEBUG : BROWSER_OUTPUT: Values: 165.9 08:49:27 INFO - 2015-12-02 08:49:27,516 DEBUG : BROWSER_OUTPUT: 08:49:27 INFO - 2015-12-02 08:49:27,516 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:189.93 Median:189.93 stddev:0.00 (0.0%) 08:49:27 INFO - 2015-12-02 08:49:27,517 DEBUG : BROWSER_OUTPUT: Values: 189.9 08:49:27 INFO - 2015-12-02 08:49:27,517 DEBUG : BROWSER_OUTPUT: 08:49:27 INFO - 2015-12-02 08:49:27,517 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.85 Median:277.85 stddev:0.00 (0.0%) 08:49:27 INFO - 2015-12-02 08:49:27,517 DEBUG : BROWSER_OUTPUT: Values: 277.9 08:49:27 INFO - 2015-12-02 08:49:27,517 DEBUG : BROWSER_OUTPUT: 08:49:27 INFO - 2015-12-02 08:49:27,517 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5218.75 Median:5218.75 stddev:0.00 (0.0%) 08:49:27 INFO - 2015-12-02 08:49:27,517 DEBUG : BROWSER_OUTPUT: Values: 5218.8 08:49:27 INFO - 2015-12-02 08:49:27,517 DEBUG : BROWSER_OUTPUT: 08:49:27 INFO - 2015-12-02 08:49:27,518 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1079.91 Median:1079.91 stddev:0.00 (0.0%) 08:49:27 INFO - 2015-12-02 08:49:27,518 DEBUG : BROWSER_OUTPUT: Values: 1079.9 08:49:27 INFO - 2015-12-02 08:49:27,518 DEBUG : BROWSER_OUTPUT: 08:49:27 INFO - 2015-12-02 08:49:27,518 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:698.81 Median:698.81 stddev:0.00 (0.0%) 08:49:27 INFO - 2015-12-02 08:49:27,518 DEBUG : BROWSER_OUTPUT: Values: 698.8 08:49:27 INFO - 2015-12-02 08:49:27,518 DEBUG : BROWSER_OUTPUT: 08:49:27 INFO - 2015-12-02 08:49:27,518 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12132.53 Median:12132.53 stddev:0.00 (0.0%) 08:49:27 INFO - 2015-12-02 08:49:27,519 DEBUG : BROWSER_OUTPUT: Values: 12132.5 08:49:27 INFO - 2015-12-02 08:49:27,519 DEBUG : BROWSER_OUTPUT: 08:49:27 INFO - 2015-12-02 08:49:27,519 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25820.51 Median:25820.51 stddev:0.00 (0.0%) 08:49:27 INFO - 2015-12-02 08:49:27,519 DEBUG : BROWSER_OUTPUT: Values: 25820.5 08:49:27 INFO - 2015-12-02 08:49:27,519 DEBUG : BROWSER_OUTPUT: 08:49:27 INFO - 2015-12-02 08:49:27,520 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:595.14 Median:595.14 stddev:0.00 (0.0%) 08:49:27 INFO - 2015-12-02 08:49:27,520 DEBUG : BROWSER_OUTPUT: Values: 595.1 08:49:27 INFO - 2015-12-02 08:49:27,520 DEBUG : BROWSER_OUTPUT: 08:49:27 INFO - 2015-12-02 08:49:27,520 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 08:49:27 INFO - 2015-12-02 08:49:27,520 DEBUG : BROWSER_OUTPUT: Values: 4830.9 08:49:27 INFO - 2015-12-02 08:49:27,521 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:49:27 INFO - 2015-12-02 08:49:27,521 DEBUG : BROWSER_OUTPUT: 08:49:28 INFO - 2015-12-02 08:49:28,393 INFO : Browser exited with error code: 0 08:49:28 INFO - 2015-12-02 08:49:28,407 INFO : Completed test v8_7 (00:00:40) 08:49:28 INFO - 2015-12-02 08:49:28,518 INFO : Completed test suite (00:20:17) 08:49:28 INFO - 2015-12-02 08:49:28,518 DEBUG : Working with test: dromaeo_css 08:49:28 INFO - 2015-12-02 08:49:28,518 DEBUG : Generating results file: dromaeo_css 08:49:28 INFO - 2015-12-02 08:49:28,520 DEBUG : Working with test: kraken 08:49:28 INFO - 2015-12-02 08:49:28,520 DEBUG : Generating results file: kraken 08:49:28 INFO - 2015-12-02 08:49:28,520 INFO : javascript benchmark 08:49:28 INFO - 2015-12-02 08:49:28,520 DEBUG : Working with test: v8_7 08:49:28 INFO - 2015-12-02 08:49:28,520 DEBUG : Generating results file: v8_7 08:49:28 INFO - 2015-12-02 08:49:28,521 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:49:28 INFO - 2015-12-02 08:49:28,575 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 08:49:28 INFO - 2015-12-02 08:49:28,575 DEBUG : process_Request line: dromaeo_css 6386.13 graph.html#tests=[[72,132,43]] 08:49:28 INFO - 2015-12-02 08:49:28,575 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:49:28 INFO - 2015-12-02 08:49:28,608 DEBUG : process_Request line: kraken 1536.70 graph.html#tests=[[232,132,43]] 08:49:28 INFO - 2015-12-02 08:49:28,609 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:49:28 INFO - 2015-12-02 08:49:28,648 DEBUG : process_Request line: v8_7 21393.04 graph.html#tests=[[230,132,43]] 08:49:28 INFO - 2015-12-02 08:49:28,649 INFO : javascript benchmark 08:49:28 INFO - 2015-12-02 08:49:28,653 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2594.3254753764018, 2678.1965410376883, 2703.040420650669, 2708.282305189124, 2722.210558937908, 4515.480719717233, 4707.058588282344, 4708.199606066968, 4758.809647614095, 4797.160496913035, 4626.629869610431, 4675.4155730533685, 4726.976365118178, 4758.904821903559, 4767.070421267854, 4249.1714115747445, 4275.337322714976, 4365.061511774968, 4381.3647021181905, 4388.1223755249075, 4186.937195942063, 4385.0, 4397.912041759163, 4424.80088396023, 4483.5516448355065, 4283.507396649394, 4302.913941721148, 4320.827166913351, 4326.762028088454, 4406.140802543506, 4286.721363111388, 4294.892627684301, 4312.654987601016, 4318.265894797861, 4321.0709697414895, 4108.281050816125, 4263.5949584789705, 4316.266234740102, 4317.76252306123, 4354.216241076605, 4551.135284295973, 4552.772361381918, 4698.600618947359, 4709.529047095263, 4741.668083234175, 5031.094403007457, 5068.138416469209, 5082.2122571001555, 5082.720450375265, 5125.769340379692, 4859.878503037417, 5090.9236361454605, 5106.361704786902, 5116.506599045567, 5139.820106296299, 4630.953690463086, 4659.510751371125, 4713.057388522241, 4729.385179926657, 4781.2111001685025, 5231.136862417735, 5244.423113457517, 5256.737163141827, 5264.657797243167, 5301.708406037705, 4806.543378379049, 4914.508549145057, 5023.949760502422, 5057.72182529957, 5057.848264552069, 4966.15575352191, 5047.217681259411, 5048.747562621854, 5059.797608095635, 5106.055379754683, 4887.120318342661, 5055.216441451581, 5056.115179843513, 5059.696418214919, 5104.642675012788, 4710.317004034396, 4834.444038935568, 4852.878678033077, 4980.601551875841, 5014.197728363444, 4157.230912281238, 4170.22850772608, 4180.874573762792, 4190.53904070552, 4216.852410165629, 3639.8857568607973, 3647.361711700442, 3651.8174091295327, 3691.3171063353366, 3693.261347730465, 4204.222218889515, 4360.0, 4362.9781851091175, 4370.0, 4383.9342409863875, 4959.851204463872, 5006.148954677714, 5007.223880298559, 5051.671641343374, 5082.390113186441, 4371.082072764755, 4371.715838470489, 4383.0, 4404.097160082176, 4448.1770872388715, 4191.266528357525, 4364.934525982113, 4376.606105450461, 4460.1971645104195, 4473.217186992263, 4809.278608208657, 4852.708837469763, 4863.465018847854, 4864.683795553277, 4875.341828853201, 5065.645404821627, 5092.516210959953, 5102.005109003709, 5133.56364708989, 5147.9227811583605, 4596.908061838812, 4694.64790140734, 4734.668573199843, 4802.399700037496, 4863.076015557032, 4982.0, 4996.750162491933, 5059.645824792229, 5065.0, 5084.7966081356335, 5069.721165335942, 5073.949260507347, 5112.412072611549, 5142.665726727751, 5151.716655583829, 4724.811007559797, 4771.1888978872985, 4851.102546028996, 4854.296127061486, 4900.166971614905, 4856.757162141949, 4913.434954980223, 4919.065377578248, 4921.532454416824, 4969.130402179677, 4632.235681112578, 4786.305985631994, 4812.133815913029, 4840.394950631171, 4853.490383509822, 4802.27965805132, 4840.95159048405, 4891.608671306358, 4899.779509921991, 4931.6301277405055, 4769.713817170981, 4869.099216644932, 4874.366332376769, 4877.195262781744, 4933.087378834927], "unit": "ms", "name": "dojo.html", "value": 4618.932647372294}, {"lowerIsBetter": false, "replicates": [578.9710514474276, 580.0979476913398, 581.4040608376414, 584.9941500584993, 630.2877748144596, 35187.82406087969, 35825.64174358256, 35864.46203306949, 35899.461508077366, 36042.0, 36999.260014799685, 37852.81073594628, 37926.8103659482, 37986.0, 38063.42904856429, 7750.96124519378, 7878.25156610124, 7895.092064412609, 7901.960490197541, 7908.881366779503, 7621.3521850642765, 7717.8070548236465, 7734.651940662656, 7770.922290777076, 7782.64978075988, 7756.534607923514, 7769.417293702967, 7823.413244006694, 7826.530408175499, 7836.4906281091835, 7823.726169584065, 7910.3276221520955, 7919.683212671515, 7920.247576480225, 7921.445498815086, 7668.731594394225, 7783.299503044753, 7785.961070194669, 7790.649420776079, 7791.415643826679, 34801.0, 34984.0, 35198.64801352005, 35221.82389088038, 35254.47118293228, 2865.813722108077, 2920.620319358491, 3023.8034527755844, 3229.1927018245437, 3294.407006738786, 26512.60231096535, 27111.45777084467, 27223.183304500897, 27571.17286481409, 27822.026229082087, 3179.5230715392645, 3189.6650851660474, 3232.482802751572, 3234.91912702182, 3322.9501557476656, 199529.0, 201603.0, 201750.0, 201908.0, 202524.0, 45471.0, 46089.30866037012, 53220.73389633105, 53652.46347536475, 53696.463035369925, 64987.67506162439, 65959.0, 66264.6686766563, 66872.66563667248, 66953.33046669471, 13894.096883702527, 14230.928845355707, 14315.0, 14347.067440616327, 14363.56909292723, 10620.575176992834, 10710.946445267724, 10714.303570267908, 10893.07408870255, 10920.453977301104, 18724.719129213074, 18829.34097306588, 18841.0, 19010.61978760417, 19264.80735192658, 7603.923960760321, 7809.471612565638, 7846.9215307847335, 7891.921080789233, 7913.564753938589, 861.1173547114133, 887.8490656588395, 889.7508697564692, 934.7943452440452, 980.666573365045, 25114.874425627753, 25706.139934790863, 26207.868960655076, 26313.0, 26578.0, 985.2955137077024, 1010.4442556593845, 1048.2871647279924, 1063.4895250279908, 1125.0476610199698, 13762.793558096637, 13789.448422063206, 13854.92176173582, 13964.441422343196, 14003.439862405594, 263032.0, 266331.0, 266623.0, 267685.0, 267897.0, 45194.096118077454, 45294.32058519125, 45396.773016134706, 45493.0, 45519.54480455219, 1204.590439250659, 1204.6265657645984, 1205.9155859089956, 1210.279883469352, 1229.0474881966368, 25060.749392506572, 25584.744152558236, 25856.482870342865, 25975.480490390466, 26021.479570408108, 39854.80072599618, 40184.799076004434, 40227.79886100551, 40244.0, 40378.97157713125, 245044.0, 245815.0, 246443.0, 246970.0, 247401.0, 29315.0, 29748.405031899674, 29797.10608681743, 29815.956441524442, 30409.847950760104, 33031.50452743259, 33917.49123763195, 33963.0, 34288.97133086011, 34420.31159376748, 28499.0, 28527.857360713064, 28785.71214287914, 28829.56755648625, 29138.0, 28545.143645690663, 28667.0, 28832.0, 29279.560806588343, 29343.0, 31226.843865780527, 32259.51610725794, 32417.0, 32489.51265731063, 32840.67159328376, 26694.733052669224, 29267.414651707273, 29407.55888661629, 29891.701082989763, 30013.849930750206, 21875.78124218801, 21941.561168776854, 22080.44798880041, 23418.18036368719, 24122.0], "unit": "ms", "name": "ext.html", "value": 16561.318741646424}, {"lowerIsBetter": false, "replicates": [333.075714891177, 333.2734638488095, 334.49658264312205, 340.50286581590876, 340.6168060931452, 15099.320530576122, 15229.866464928995, 15840.445584404548, 16430.178491075458, 16585.751213731804, 9649.614015439392, 9865.901340986587, 12713.491460341575, 14523.854761452383, 14545.709085818276, 4455.1089782043555, 4576.748278844662, 4578.496365399803, 4914.97542512287, 5078.949210507884, 4913.9262911056185, 4930.950690493103, 4954.3063971044085, 4961.6278779091535, 4979.377577802775, 3312.933741325184, 3391.9321613567836, 4994.450610432849, 5759.884802303952, 6413.358664133572, 6695.430888374494, 6697.397234248892, 6711.563748356366, 6726.293739157391, 6756.12170417845, 6286.968565157145, 6358.841028974266, 6366.267879193906, 6375.0, 6406.199225096863, 20944.16223351064, 20953.68569471459, 21083.3674989749, 21187.788122118734, 21719.13123475075, 1948.6589846776758, 1989.9303524376721, 2025.908834102469, 2052.9281475148446, 2062.9690554641693, 12618.369081545887, 13354.86645133546, 13776.173429594157, 13909.513167039106, 14408.207548584824, 1742.3988723890238, 1808.7739032620923, 1858.2009735813594, 1876.5777700017522, 1921.3851567498407, 58534.414655853325, 62201.68899155566, 63274.0508892367, 63568.0, 63704.68147659232, 15276.465323713617, 15401.152936588594, 15411.229438528253, 15456.304466299043, 15537.30082146306, 22736.431589210402, 22883.199088031837, 22921.0, 22932.770672293063, 22939.197128100437, 8161.673533058611, 8171.346292296602, 8204.220599043081, 8241.546714930737, 8272.255497005299, 6368.4586810121655, 6431.389018043278, 6663.06717059612, 6788.219354774165, 6815.727370905208, 7596.582187979714, 7617.314441700273, 7784.104827944859, 7819.413543984224, 7871.527708337518, 2940.1767505098605, 3027.8637461314293, 3031.257341951236, 3132.9216769580944, 3192.409404260219, 372.88813355993096, 374.76577139287946, 403.4392194849162, 408.03703260305656, 841.9284360829275, 9127.178553930178, 9501.42991420517, 13543.59369218925, 15149.0, 16987.74518382225, 845.885805416261, 850.2942557677237, 856.9143085691381, 867.6572753762355, 902.5712786426526, 8860.246879015227, 8895.644174233088, 9250.213731832735, 9333.533323333806, 9394.765130871783, 494989.0, 498677.0, 504573.0, 509439.0, 510405.0, 70256.64871675608, 70446.0, 72522.0, 72660.0, 74512.25487745162, 1039.542601255445, 1071.1912506057877, 1072.0405237312561, 1076.0799516413354, 1082.929609575375, 14723.33744981457, 14736.0, 14898.627534311729, 15160.545183644508, 15418.841362209523, 32932.67067329296, 33298.5005224917, 33365.33269334551, 34458.48312275368, 34605.13487162841, 43585.34621980736, 43703.0, 43913.56086439094, 44045.11909761851, 44810.327845083004, 8594.226519613265, 8728.78178045554, 8732.956335218283, 8796.428232164888, 8841.469511829311, 9981.900180998387, 10146.086852183338, 10481.685549433529, 16259.51221463358, 16374.099424531765, 13168.275744833743, 13826.516071937434, 14068.366923488264, 14098.859011409755, 14222.786658199928, 12979.675508111995, 14005.5098071567, 14219.502317419254, 14303.856961430252, 14332.211728355041, 14009.789853152415, 14389.784153237919, 14432.711345773236, 14521.709565808836, 14765.483208088095, 8607.65569377218, 8662.177093176138, 8751.824963500821, 8764.868526971974, 8776.122387761172, 10784.406857622906, 13886.236257005557, 13942.860571394156, 13972.301384930915, 14170.929145354206], "unit": "ms", "name": "jquery.html", "value": 8888.335080297984}, {"lowerIsBetter": false, "replicates": [1365.1263191557405, 1395.4557722488232, 1406.5147524104193, 1632.4939268826663, 1704.974425383619, 6279.434850863421, 6486.61080335179, 7181.892271615923, 7412.073490813642, 7433.739819106332, 6904.930950690492, 7131.322524360177, 7175.354218120368, 7240.96379518103, 7241.1672657644385, 2017.263698749953, 2064.834813214939, 2065.535254567725, 2067.0491573876034, 2067.462459760458, 2004.1582535335122, 2041.969370459437, 2053.1992522916075, 2053.3224036068136, 2059.866108702937, 2070.534129820793, 2098.8635738677012, 2099.9790002100012, 2116.4179850541145, 2125.7024016637683, 2058.60886431579, 2061.8556701030934, 2063.7213976113185, 2072.885991270487, 2074.0459388681224, 1754.8508376787988, 1757.1741281597629, 1778.2975724588714, 1803.2967142814314, 1804.3684710351404, 7258.419326453871, 7306.232845551247, 7339.0, 7350.63246837656, 7382.815429614303, 4152.1695660867645, 4152.83388664453, 4217.662586993033, 4219.092895027553, 4231.597998190167, 2647.139679604117, 2689.031948498539, 2718.9048383306686, 2774.2925553983805, 2774.9583756243674, 830.3896635972555, 847.1063028504925, 853.8633818589058, 858.3219256787131, 861.7285555050139, 9696.46669433181, 9702.223822094216, 9714.077162669535, 9734.561944712505, 9736.172425343784, 3843.557990831034, 3850.4801851749653, 3871.632194941476, 3890.027493126718, 3912.6478616924614, 8310.750677479686, 8374.0, 8385.622646980779, 8422.578871056423, 8424.452410593292, 4231.090315582164, 4248.936265956013, 4265.91468170641, 4269.551697071763, 4269.914601707948, 3695.5750088740137, 3789.1285004448578, 3789.7157713171623, 3832.5209348831395, 3860.7876566789096, 3222.8227447490613, 3239.5950506186728, 3251.5935508061493, 3258.7718859679594, 3260.0, 920.4753290624413, 928.7863791328033, 929.0662883801871, 936.0732874454242, 942.3591957468986, 1175.4769127738246, 1193.4271549656214, 1194.1163538981266, 1204.6988252936767, 1227.8035514317667, 6745.224299205556, 6868.244493105754, 6869.416099631488, 6889.104416425933, 6947.687354069079, 394.1683048767099, 404.9453323801249, 406.81286608160576, 407.5659422714799, 408.90799570097084, 5344.0, 5346.064438723286, 5383.300170977748, 5423.267858839085, 5433.728313584305, 8440.240378365976, 8443.915560844312, 8633.309335253165, 8653.870191947126, 8733.868991965126, 8447.0, 8469.3647976402, 8477.491350518989, 8523.531205783742, 8533.701320453754, 6565.835854103686, 6674.599524028574, 6705.932940670628, 6717.462602991749, 6794.592324460548, 6432.839179020562, 6453.903191452226, 6456.354364563694, 6463.0, 6503.739850405931, 7508.2867127622785, 7624.085109786861, 7695.92304076952, 7805.063392392949, 7813.02337207849, 7745.845083098194, 7756.634226560953, 7758.728444504641, 7798.220177982384, 8025.478343907627, 5297.152455607084, 5360.088784906653, 5918.556108291981, 5935.495482883831, 5976.103584462192, 6680.265170831108, 6836.931630683828, 6846.691898864464, 6879.0, 6915.343042410963, 6461.57999730016, 6592.373724496165, 6603.504737144637, 6643.534952553275, 6716.227633821977, 6237.750489980532, 6274.341194174728, 6276.843078923063, 6328.525360598066, 6363.7772677956045, 6573.309802470863, 6573.375529324707, 6616.8345791355605, 6640.468762499085, 6671.099401580725, 5512.944870551403, 5991.041433370814, 5993.850153746192, 6028.487578555696, 6084.787032453843, 6173.629582224901, 6270.028145637433, 6276.811695649138, 6282.2147231596055, 6282.340354262737], "unit": "ms", "name": "mootools.html", "value": 3969.5807790636195}, {"lowerIsBetter": false, "replicates": [287.53419460474026, 294.2247178684168, 297.2954098785878, 298.75949860362397, 304.19692013085444, 5510.972445137779, 5514.751836167372, 5548.056830338842, 5587.916181257274, 5691.4024027477035, 5519.199716041172, 5570.192322113301, 5588.050031494646, 5596.720163991805, 5603.187537807015, 4108.075682971337, 4249.44757181566, 4249.532551419341, 4253.914921701572, 4259.10558782656, 4196.895077623053, 4227.661787057028, 4235.639970602487, 4236.364545318196, 4251.319788833787, 4197.41236226927, 4204.11713540157, 4205.264078786216, 4205.7897105144775, 4209.97895010526, 4187.623113919732, 4198.391233271173, 4202.621764041251, 4205.705600607944, 4223.13425747721, 3622.6920711739535, 3623.836927338276, 3626.746127771057, 3632.9273414531563, 3677.9448308275396, 5124.4106927703415, 5131.512506311894, 5274.7626356814035, 5285.603579731535, 5295.920561191585, 4762.6904251223905, 4817.975910120427, 4836.443808961979, 4839.419269687624, 4847.079054979543, 5790.739416726257, 5832.154337621064, 5857.326407463153, 5864.912026319608, 5866.413358664142, 3884.8057597120032, 3963.147923196527, 3966.167104907944, 3976.08550033491, 3983.203359328146, 6027.849303767397, 6134.9386506134815, 6141.201643786324, 6143.662098584576, 6144.508439324888, 4102.528209255974, 4103.261412945639, 4114.485689288839, 4115.588441155861, 4116.506019277646, 4153.54311025787, 4180.832766689359, 4189.07840275139, 4191.643710284599, 4197.118605092965, 4813.109574728686, 4819.277108433693, 4825.30033145192, 4827.493113223061, 4835.637327200474, 5594.440555944373, 5746.913796293059, 5755.9424405756245, 5798.768049278066, 5812.476877081083, 1453.4694836384645, 1454.1493226462426, 1455.8689717925438, 1455.890808189369, 1457.103881113129, 963.5230560872413, 964.6671898195111, 967.260046064761, 983.3509883476871, 985.935914165577, 4994.875128121826, 5018.247262910592, 5045.899082018339, 5070.467600901926, 5074.517920797518, 6026.969865150646, 6040.214772079602, 6048.243969503812, 6053.606515576562, 6081.665508397081, 5085.364329458817, 5104.2088476286235, 5111.616628752784, 5115.0, 5127.461616530285, 3199.1362332170183, 3250.5124231365485, 3267.18320419895, 3273.3126043530647, 3288.391647545212, 5721.628094173865, 5734.025215713339, 5737.79095048401, 5738.139279108083, 5755.539556835443, 6163.137160797492, 6283.8114856554375, 6291.087792270096, 6317.084022816666, 6322.9051564226575, 5662.980663480613, 5669.518090962314, 5706.800261990894, 5719.771209151588, 5741.0, 6067.514598832171, 6069.423404776539, 6071.7571297147615, 6084.60450070744, 6087.847803804941, 5708.286464191976, 5897.056470964625, 5923.052311630291, 5928.4960778334325, 5944.970275148597, 5775.942240577709, 5783.016887129283, 5786.42135786418, 5800.651960882361, 5813.476787089182, 4072.4095006224525, 4102.692298077596, 4117.155983023533, 4118.814653340547, 4123.721646289539, 5999.160117583455, 6135.631862088289, 6136.417040381157, 6146.846328841636, 6146.877062458636, 5875.618084824473, 5883.058710606282, 5893.616914900689, 5899.941000589939, 5910.143029260647, 5879.20630714848, 5880.558958078076, 5882.647041177543, 5889.911651325147, 5896.351401345934, 5615.943840561706, 5712.485876271156, 5713.600047996601, 5731.484166425042, 5766.481016708349, 5878.0, 5893.2044174035955, 5915.585908986502, 5933.6439813609595, 5939.198208241832, 5616.522595579421, 5663.5469162467725, 5725.914111288417, 5731.828045158652, 5738.913916291175], "unit": "ms", "name": "prototype.html", "value": 4343.626662943459}, {"lowerIsBetter": false, "replicates": [660.6020146866874, 676.0964327017167, 701.1516065560668, 748.2853874549805, 794.8807678848176, 11382.0, 11561.942190289048, 11736.471858766354, 11771.529138834458, 11823.0, 13567.660808479768, 13611.659708507292, 13633.795493067611, 13807.585772426843, 13859.445622175126, 616.4698359410903, 627.2660986645612, 780.7384526183721, 785.7053604898164, 806.2824086562964, 807.6446363600027, 808.1998821167032, 808.6037841457702, 809.0614886731393, 815.09524427885, 840.470503582742, 849.3969281809923, 850.2305413600701, 850.3324889961382, 854.1117238072397, 841.4698739793921, 842.9536375499345, 845.349081207473, 846.4582667093065, 846.9872951905726, 615.8583525789094, 624.4099326136802, 625.9123722678829, 626.2172284644195, 627.0, 11787.705307367298, 11921.582744603897, 11931.94034029833, 11940.343281119534, 11945.283283003047, 11142.27575207609, 11221.0, 11510.59712910044, 11519.769604607862, 11654.592089276919, 9202.263818894473, 9450.57472413743, 9502.239820814388, 9563.0, 9577.329586928918, 3131.01373067483, 3186.617605887285, 3197.344544368399, 3211.550382946389, 3231.515272709089, 42488.150236995396, 42898.35652465247, 42942.0, 43250.78374608107, 43377.13245735068, 9047.140521650434, 9268.0, 9285.535723213812, 9377.624895004259, 9485.098915603006, 16052.0, 16267.105309208107, 16294.0, 16304.347826087062, 16341.509754707378, 5663.546916246691, 5665.830025099253, 5715.228444159985, 5722.113072473773, 5791.160281759121, 3622.5109610202285, 3626.5829429615933, 3658.579263384692, 3708.8331025103935, 3711.9628803712158, 2686.4224191798858, 2710.5798601216843, 2720.455908818244, 2722.2377734234447, 2722.441899410616, 480.14294484345976, 493.622378880157, 501.33573015754274, 507.0720581336146, 514.5497689521668, 539.371632048659, 599.8230521996022, 609.4819403506983, 611.865389614293, 622.8115920435129, 7674.961625191839, 7676.654550545239, 7704.5476084777765, 7784.260495252942, 7837.725679601187, 533.1230126441981, 533.8078291814943, 538.2383926743614, 621.3817251834363, 666.4168852254278, 3553.857845686195, 3679.466477360821, 3707.8331475083687, 3769.1707824278615, 3812.866549670748, 48808.51191488039, 49017.75491122593, 49243.753781230866, 49329.50670493249, 50189.74905125524, 44843.55156448394, 44982.32526512105, 45055.77472112684, 45472.54527454749, 46141.077178456915, 41845.58154418478, 41878.0, 42098.57901421069, 42762.0, 42817.78591107025, 7967.28294453502, 8049.436539442183, 8307.252347288773, 8371.497710137412, 8561.657533698832, 30396.696033039385, 30991.69008309888, 31143.598538066293, 32137.35725285528, 32629.510557341186, 35763.46354804628, 37042.629573704995, 39858.800705996284, 40176.0, 40217.79891100526, 9865.852012219679, 10332.431716255678, 10344.586216551254, 10524.736881577715, 10600.681979540626, 11088.833667494833, 11181.552737890719, 11239.438028098399, 11268.323900565993, 11496.425178741198, 10576.471176440993, 10680.57277708883, 10810.29733067348, 11059.944700276446, 11077.723056923642, 10633.308834925705, 10756.085732712807, 10885.183611229348, 11021.669349919515, 11164.497597607964, 10091.293609447268, 10470.947645261725, 10824.783504329711, 10884.7278818027, 11234.55061797519, 9053.0, 9313.627454902, 9365.859512107187, 9447.574859131493, 9938.55276512573, 8944.463332200088, 9217.815643687223, 9231.76920576964, 9564.521773911416, 9902.504874756378], "unit": "ms", "name": "yui.html", "value": 5785.2892253705395}], "name": "dromaeo_css", "value": 6386.125496661309}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 111.0, 111.0, 112.0, 122.0, 113.0, 110.0, 111.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 111.9}, {"lowerIsBetter": true, "replicates": [159.0, 140.0, 152.0, 171.0, 130.0, 151.0, 154.0, 148.0, 165.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.1}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 164.0, 162.0, 162.0, 162.0, 166.0, 164.0, 164.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 163.0}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 72.0, 79.0, 72.0, 136.0, 73.0, 78.0, 71.0, 77.0], "unit": "ms", "name": "audio-fft", "value": 80.1}, {"lowerIsBetter": true, "replicates": [96.0, 94.0, 132.0, 93.0, 94.0, 96.0, 131.0, 93.0, 94.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 105.5}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 114.0, 110.0, 112.0, 114.0, 110.0, 109.0, 110.0, 111.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 111.1}, {"lowerIsBetter": true, "replicates": [148.0, 149.0, 148.0, 148.0, 148.0, 149.0, 149.0, 147.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.0}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 72.0, 70.0, 71.0, 72.0, 69.0, 71.0, 70.0, 73.0], "unit": "ms", "name": "json-parse-financial", "value": 71.2}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 69.0, 68.0, 68.0, 69.0, 69.0, 69.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [90.0, 84.0, 86.0, 85.0, 83.0, 83.0, 84.0, 83.0, 85.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.8}, {"lowerIsBetter": true, "replicates": [134.0, 124.0, 129.0, 122.0, 130.0, 126.0, 134.0, 130.0, 129.0, 131.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 128.9}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 152.0, 147.0, 141.0, 149.0, 159.0, 141.0, 146.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.5}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 71.0, 70.0, 70.0, 69.0, 71.0, 70.0, 69.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.9}], "name": "kraken", "value": 1536.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.89250165892503], "unit": "score", "name": "Richards", "value": 212.80045599999988}, {"lowerIsBetter": false, "replicates": [189.9335232668566], "unit": "score", "name": "DeltaBlue", "value": 348.11126999999993}, {"lowerIsBetter": false, "replicates": [277.85495971103086], "unit": "score", "name": "Encrypt", "value": 957.9854189999998}, {"lowerIsBetter": false, "replicates": [5218.75], "unit": "score", "name": "Decrypt", "value": 51.00474251497002}, {"lowerIsBetter": false, "replicates": [1079.913606911447], "unit": "score", "name": "RayTrace", "value": 685.2298140000004}, {"lowerIsBetter": false, "replicates": [698.8120195667366], "unit": "score", "name": "Earley", "value": 953.7085530000003}, {"lowerIsBetter": false, "replicates": [12132.530120481928], "unit": "score", "name": "Boyer", "value": 54.93190566037737}, {"lowerIsBetter": false, "replicates": [25820.51282051282], "unit": "score", "name": "RegExp", "value": 35.28144488579943}, {"lowerIsBetter": false, "replicates": [595.1393005334915], "unit": "score", "name": "Splay", "value": 136.9276065737051}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21393.042435508825}]} 08:49:28 INFO - RETURN: dromaeo_css: 6386.13 08:49:28 INFO - RETURN: kraken: 1536.70 08:49:28 INFO - RETURN: v8_7: 21393.04 08:49:28 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21393.04"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1536.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6386.13"}}} 08:49:28 INFO - Return code: 0 08:49:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:49:28 INFO - # TBPL SUCCESS # 08:49:28 INFO - Running post-action listener: _resource_record_post_action 08:49:28 INFO - Running post-run listener: _resource_record_post_run 08:49:29 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 10539008; Write bytes: 403017728; Read time: 3704; Write time: 337568 08:49:29 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 638976; Read time: 0; Write time: 52 08:49:29 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 8777728; Write bytes: 402378752; Read time: 3648; Write time: 337516 08:49:29 INFO - Running post-run listener: _upload_blobber_files 08:49:29 INFO - Blob upload gear active. 08:49:29 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:49:29 INFO - Copying logs to upload dir... 08:49:29 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1268.988958 ========= master_lag: 0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-02 08:49:29.954154) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-02 08:49:29.957411) ========= 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=7d909545e45784438f4e8e36000001b3-1449073098.408375-644269301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/RX5nd2QMT0G5GgqbG5b18g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009938 build_url: 'https://queue.taskcluster.net/v1/task/RX5nd2QMT0G5GgqbG5b18g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-02 08:49:30.011753) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 08:49:30.012081) ========= 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=7d909545e45784438f4e8e36000001b3-1449073098.408375-644269301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 08:49:30.062027) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-02 08:49:30.062347) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-02 08:49:30.062721) ========= ========= Total master_lag: 0.39 =========