builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-067 starttime: 1453729838.4 results: success (0) buildid: 20160125031008 builduid: 72a57ce5081241e2ad27fb1a24432dd7 revision: 97e6ca995311c2ea072e492021049a68fa5d19b1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 05:50:38.399814) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 05:50:38.400278) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 05:50:38.400570) ========= bash -c pwd in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1453726832.279669-280590249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006329 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 05:50:38.431983) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 05:50:38.432266) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 05:50:38.452465) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 05:50:38.452774) ========= rm -rf properties in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1453726832.279669-280590249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004631 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 05:50:38.502648) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 05:50:38.502957) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 05:50:38.503342) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 05:50:38.503655) ========= 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-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1453726832.279669-280590249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-25 05:50:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 21.0M=0.001s 2016-01-25 05:50:39 (21.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162921 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 05:50:38.681877) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 05:50:38.682300) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1453726832.279669-280590249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018576 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 05:50:38.733784) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 05:50:38.734151) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 97e6ca995311c2ea072e492021049a68fa5d19b1 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 97e6ca995311c2ea072e492021049a68fa5d19b1 --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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1453726832.279669-280590249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-25 05:50:39,396 truncating revision to first 12 chars 2016-01-25 05:50:39,396 Setting DEBUG logging. 2016-01-25 05:50:39,396 attempt 1/10 2016-01-25 05:50:39,396 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/97e6ca995311?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-25 05:50:39,651 unpacking tar archive at: mozilla-aurora-97e6ca995311/testing/mozharness/ program finished with exit code 0 elapsedTime=0.540782 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 05:50:39.287681) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 05:50:39.288036) ========= echo 97e6ca995311c2ea072e492021049a68fa5d19b1 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'97e6ca995311c2ea072e492021049a68fa5d19b1'] 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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1453726832.279669-280590249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 97e6ca995311c2ea072e492021049a68fa5d19b1 program finished with exit code 0 elapsedTime=0.004661 script_repo_revision: '97e6ca995311c2ea072e492021049a68fa5d19b1' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 05:50:39.339839) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 05:50:39.340166) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 05:50:39.350764) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 25 mins, 58 secs) (at 2016-01-25 05:50:39.351062) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1453726832.279669-280590249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:50:40 INFO - MultiFileLogger online at 20160125 05:50:40 in /builds/slave/test-pgo 05:50:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 05:50:40 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:50:40 INFO - {'append_to_log': False, 05:50:40 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:50:40 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:50:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:50:40 INFO - 'branch': 'Mozilla-Aurora', 05:50:40 INFO - 'buildbot_json_path': 'buildprops.json', 05:50:40 INFO - 'config_files': ('talos/linux_config.py',), 05:50:40 INFO - 'default_actions': ('clobber', 05:50:40 INFO - 'read-buildbot-config', 05:50:40 INFO - 'download-and-extract', 05:50:40 INFO - 'populate-webroot', 05:50:40 INFO - 'create-virtualenv', 05:50:40 INFO - 'install', 05:50:40 INFO - 'run-tests'), 05:50:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:50:40 INFO - 'download_minidump_stackwalk': True, 05:50:40 INFO - 'download_symbols': 'ondemand', 05:50:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:50:40 INFO - 'tooltool.py': '/tools/tooltool.py', 05:50:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:50:40 INFO - '/tools/misc-python/virtualenv.py')}, 05:50:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:50:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:50:40 INFO - 'installer_path': 'installer.exe', 05:50:40 INFO - 'log_level': 'info', 05:50:40 INFO - 'log_name': 'talos', 05:50:40 INFO - 'log_to_console': True, 05:50:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:50:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:50:40 INFO - 'opt_config_files': (), 05:50:40 INFO - 'pip_index': False, 05:50:40 INFO - 'sps_profile': False, 05:50:40 INFO - 'sps_profile_interval': 0, 05:50:40 INFO - 'suite': 'dromaeojs-e10s', 05:50:40 INFO - 'system_bits': '32', 05:50:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:50:40 INFO - 'title': 'talos-linux64-ix-067', 05:50:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:50:40 INFO - 'use_talos_json': True, 05:50:40 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:50:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:50:40 INFO - 'work_dir': 'build'} 05:50:40 INFO - ##### 05:50:40 INFO - ##### Running clobber step. 05:50:40 INFO - ##### 05:50:40 INFO - Running pre-action listener: _resource_record_pre_action 05:50:40 INFO - Running main action method: clobber 05:50:40 INFO - rmtree: /builds/slave/test-pgo/build 05:50:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:50:40 INFO - Running post-action listener: _resource_record_post_action 05:50:40 INFO - ##### 05:50:40 INFO - ##### Running read-buildbot-config step. 05:50:40 INFO - ##### 05:50:40 INFO - Running pre-action listener: _resource_record_pre_action 05:50:40 INFO - Running main action method: read_buildbot_config 05:50:40 INFO - Using buildbot properties: 05:50:40 INFO - { 05:50:40 INFO - "properties": { 05:50:40 INFO - "buildnumber": 107, 05:50:40 INFO - "product": "firefox", 05:50:40 INFO - "script_repo_revision": "production", 05:50:40 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 05:50:40 INFO - "repository": "", 05:50:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 05:50:40 INFO - "buildid": "20160125031008", 05:50:40 INFO - "slavename": "talos-linux64-ix-067", 05:50:40 INFO - "pgo_build": "True", 05:50:40 INFO - "basedir": "/builds/slave/test-pgo", 05:50:40 INFO - "project": "", 05:50:40 INFO - "platform": "ubuntu64_hw", 05:50:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:50:40 INFO - "slavebuilddir": "test", 05:50:40 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 05:50:40 INFO - "branch": "mozilla-aurora", 05:50:40 INFO - "repo_path": "releases/mozilla-aurora", 05:50:40 INFO - "stage_platform": "linux64-pgo", 05:50:40 INFO - "builduid": "72a57ce5081241e2ad27fb1a24432dd7", 05:50:40 INFO - "revision": "97e6ca995311c2ea072e492021049a68fa5d19b1" 05:50:40 INFO - }, 05:50:40 INFO - "sourcestamp": { 05:50:40 INFO - "repository": "", 05:50:40 INFO - "hasPatch": false, 05:50:40 INFO - "project": "", 05:50:40 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 05:50:40 INFO - "changes": [ 05:50:40 INFO - { 05:50:40 INFO - "category": null, 05:50:40 INFO - "files": [ 05:50:40 INFO - { 05:50:40 INFO - "url": null, 05:50:40 INFO - "name": "https://queue.taskcluster.net/v1/task/pgZ1QC9cScidWMmi6Xh3Pg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 05:50:40 INFO - } 05:50:40 INFO - ], 05:50:40 INFO - "repository": "", 05:50:40 INFO - "rev": "97e6ca995311c2ea072e492021049a68fa5d19b1", 05:50:40 INFO - "who": "cbook@mozilla.com", 05:50:40 INFO - "when": 1453729758, 05:50:40 INFO - "number": 7510905, 05:50:40 INFO - "comments": "Bug 1232707 - Import the latest version of the Loop system add-on. r=me for import of already reviewed code. a=sylvestre", 05:50:40 INFO - "project": "", 05:50:40 INFO - "at": "Mon 25 Jan 2016 05:49:18", 05:50:40 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 05:50:40 INFO - "revlink": "", 05:50:40 INFO - "properties": [ 05:50:40 INFO - [ 05:50:40 INFO - "buildid", 05:50:40 INFO - "20160125031008", 05:50:40 INFO - "Change" 05:50:40 INFO - ], 05:50:40 INFO - [ 05:50:40 INFO - "builduid", 05:50:40 INFO - "72a57ce5081241e2ad27fb1a24432dd7", 05:50:40 INFO - "Change" 05:50:40 INFO - ], 05:50:40 INFO - [ 05:50:40 INFO - "pgo_build", 05:50:40 INFO - "True", 05:50:40 INFO - "Change" 05:50:40 INFO - ] 05:50:40 INFO - ], 05:50:40 INFO - "revision": "97e6ca995311c2ea072e492021049a68fa5d19b1" 05:50:40 INFO - } 05:50:40 INFO - ], 05:50:40 INFO - "revision": "97e6ca995311c2ea072e492021049a68fa5d19b1" 05:50:40 INFO - } 05:50:40 INFO - } 05:50:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/pgZ1QC9cScidWMmi6Xh3Pg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 05:50:40 INFO - Running post-action listener: _resource_record_post_action 05:50:40 INFO - ##### 05:50:40 INFO - ##### Running download-and-extract step. 05:50:40 INFO - ##### 05:50:40 INFO - Running pre-action listener: _resource_record_pre_action 05:50:40 INFO - Running main action method: download_and_extract 05:50:40 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:50:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:40 INFO - https://queue.taskcluster.net/v1/task/pgZ1QC9cScidWMmi6Xh3Pg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:50:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pgZ1QC9cScidWMmi6Xh3Pg/artifacts/public/build/test_packages.json 05:50:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pgZ1QC9cScidWMmi6Xh3Pg/artifacts/public/build/test_packages.json 05:50:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pgZ1QC9cScidWMmi6Xh3Pg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:50:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pgZ1QC9cScidWMmi6Xh3Pg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:50:41 INFO - Downloaded 1302 bytes. 05:50:41 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:50:41 INFO - Using the following test package requirements: 05:50:41 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 05:50:41 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 05:50:41 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 05:50:41 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 05:50:41 INFO - u'jsshell-linux-x86_64.zip'], 05:50:41 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 05:50:41 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 05:50:41 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 05:50:41 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 05:50:41 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 05:50:41 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 05:50:41 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 05:50:41 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 05:50:41 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 05:50:41 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 05:50:41 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 05:50:41 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 05:50:41 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:50:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:41 INFO - https://queue.taskcluster.net/v1/task/pgZ1QC9cScidWMmi6Xh3Pg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:50:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pgZ1QC9cScidWMmi6Xh3Pg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 05:50:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pgZ1QC9cScidWMmi6Xh3Pg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 05:50:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pgZ1QC9cScidWMmi6Xh3Pg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 05:50:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pgZ1QC9cScidWMmi6Xh3Pg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:50:42 INFO - Downloaded 21579469 bytes. 05:50:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:50:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 05:50:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:50:43 INFO - Return code: 0 05:50:43 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:50:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:43 INFO - https://queue.taskcluster.net/v1/task/pgZ1QC9cScidWMmi6Xh3Pg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:50:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pgZ1QC9cScidWMmi6Xh3Pg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 05:50:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pgZ1QC9cScidWMmi6Xh3Pg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 05:50:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pgZ1QC9cScidWMmi6Xh3Pg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 05:50:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pgZ1QC9cScidWMmi6Xh3Pg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:50:45 INFO - Downloaded 21579469 bytes. 05:50:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:50:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 05:50:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:50:46 INFO - Return code: 0 05:50:46 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')]} 05:50:46 INFO - https://queue.taskcluster.net/v1/task/pgZ1QC9cScidWMmi6Xh3Pg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:50:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pgZ1QC9cScidWMmi6Xh3Pg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 05:50:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pgZ1QC9cScidWMmi6Xh3Pg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 05:50:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pgZ1QC9cScidWMmi6Xh3Pg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 05:50:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pgZ1QC9cScidWMmi6Xh3Pg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:50:47 INFO - Downloaded 11132038 bytes. 05:50:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 05:50:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 05:50:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 05:50:47 INFO - Return code: 0 05:50:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:47 INFO - https://queue.taskcluster.net/v1/task/pgZ1QC9cScidWMmi6Xh3Pg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:50:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pgZ1QC9cScidWMmi6Xh3Pg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 05:50:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pgZ1QC9cScidWMmi6Xh3Pg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 05:50:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pgZ1QC9cScidWMmi6Xh3Pg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 05:50:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pgZ1QC9cScidWMmi6Xh3Pg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:50:49 INFO - Downloaded 58091263 bytes. 05:50:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/pgZ1QC9cScidWMmi6Xh3Pg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 05:50:49 INFO - mkdir: /builds/slave/test-pgo/properties 05:50:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:50:49 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:50:49 INFO - Contents: 05:50:49 INFO - build_url:https://queue.taskcluster.net/v1/task/pgZ1QC9cScidWMmi6Xh3Pg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 05:50:49 INFO - Running post-action listener: _resource_record_post_action 05:50:49 INFO - Running post-action listener: set_extra_try_arguments 05:50:49 INFO - ##### 05:50:49 INFO - ##### Running populate-webroot step. 05:50:49 INFO - ##### 05:50:49 INFO - Running pre-action listener: _resource_record_pre_action 05:50:49 INFO - Running main action method: populate_webroot 05:50:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:50:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:50:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:50:49 INFO - '--tppagecycles', 05:50:49 INFO - '7'], 05:50:49 INFO - 'tests': ['tsvgm']}}, 05:50:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:50:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:50:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:50:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:50:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:50:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:50:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:50:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:49 INFO - 'talos_options': ['--e10s'], 05:50:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:50:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:49 INFO - 'tests': ['damp', 'tps']}, 05:50:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:49 INFO - 'talos_options': ['--e10s'], 05:50:49 INFO - 'tests': ['damp', 'tps']}, 05:50:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:50:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:50:49 INFO - 'other': {'tests': ['a11yr', 05:50:49 INFO - 'ts_paint', 05:50:49 INFO - 'tpaint', 05:50:49 INFO - 'sessionrestore', 05:50:49 INFO - 'sessionrestore_no_auto_restore']}, 05:50:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:50:49 INFO - 'tests': ['a11yr', 05:50:49 INFO - 'ts_paint', 05:50:49 INFO - 'tpaint', 05:50:49 INFO - 'sessionrestore', 05:50:49 INFO - 'sessionrestore_no_auto_restore']}, 05:50:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:50:49 INFO - 'tests': ['a11yr', 05:50:49 INFO - 'ts_paint', 05:50:49 INFO - 'tpaint', 05:50:49 INFO - 'sessionrestore', 05:50:49 INFO - 'sessionrestore_no_auto_restore']}, 05:50:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:50:49 INFO - 'tests': ['a11yr', 05:50:49 INFO - 'ts_paint', 05:50:49 INFO - 'tpaint', 05:50:49 INFO - 'sessionrestore', 05:50:49 INFO - 'sessionrestore_no_auto_restore']}, 05:50:49 INFO - 'other_l64': {'tests': ['a11yr', 05:50:49 INFO - 'ts_paint', 05:50:49 INFO - 'tpaint', 05:50:49 INFO - 'sessionrestore', 05:50:49 INFO - 'sessionrestore_no_auto_restore']}, 05:50:49 INFO - 'other_nol64': {'tests': ['a11yr', 05:50:49 INFO - 'ts_paint', 05:50:49 INFO - 'tpaint', 05:50:49 INFO - 'sessionrestore', 05:50:49 INFO - 'sessionrestore_no_auto_restore']}, 05:50:49 INFO - 'svgr': {'tests': ['tsvgx', 05:50:49 INFO - 'tsvgr_opacity', 05:50:49 INFO - 'tart', 05:50:49 INFO - 'tscrollx', 05:50:49 INFO - 'cart']}, 05:50:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:50:49 INFO - 'tests': ['tsvgx', 05:50:49 INFO - 'tsvgr_opacity', 05:50:49 INFO - 'tart', 05:50:49 INFO - 'tscrollx', 05:50:49 INFO - 'cart']}, 05:50:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:49 INFO - 'tests': ['tp5o']}, 05:50:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:49 INFO - 'talos_options': ['--e10s'], 05:50:49 INFO - 'tests': ['tp5o']}, 05:50:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:49 INFO - 'talos_options': ['--xperf_path', 05:50:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:50:49 INFO - 'tests': ['tp5n']}, 05:50:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:49 INFO - 'talos_options': ['--e10s', 05:50:49 INFO - '--xperf_path', 05:50:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:50:49 INFO - 'tests': ['tp5n']}}, 05:50:49 INFO - 'talos.zip': {'path': '', 05:50:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:50:49 INFO - Running post-action listener: _resource_record_post_action 05:50:49 INFO - ##### 05:50:49 INFO - ##### Running create-virtualenv step. 05:50:49 INFO - ##### 05:50:49 INFO - Running pre-action listener: _resource_record_pre_action 05:50:49 INFO - Running main action method: create_virtualenv 05:50:49 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:50:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:50:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:50:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:50:49 INFO - Using real prefix '/usr' 05:50:49 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:50:50 INFO - Installing distribute.............................................................................................................................................................................................done. 05:50:52 INFO - Installing pip.................done. 05:50:52 INFO - Return code: 0 05:50:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1d42c64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x118d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121fa50>, '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 0x118b550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118b9e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453726832.279669-280590249', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 05:50:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:50:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:50:52 INFO - Using env: {'DISPLAY': ':0', 05:50:52 INFO - 'HOME': '/home/cltbld', 05:50:52 INFO - 'LANG': 'en_US.UTF-8', 05:50:52 INFO - 'LANGUAGE': 'en_US:en', 05:50:52 INFO - 'LOGNAME': 'cltbld', 05:50:52 INFO - 'MAIL': '/var/mail/cltbld', 05:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:52 INFO - 'MOZ_NO_REMOTE': '1', 05:50:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:52 INFO - 'NO_EM_RESTART': '1', 05:50:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:50:52 INFO - 'PWD': '/builds/slave/test-pgo', 05:50:52 INFO - 'SHELL': '/bin/bash', 05:50:52 INFO - 'SHLVL': '1', 05:50:52 INFO - 'TERM': 'linux', 05:50:52 INFO - 'TMOUT': '86400', 05:50:52 INFO - 'USER': 'cltbld', 05:50:52 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453726832.279669-280590249', 05:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:52 INFO - '_': '/tools/buildbot/bin/python'} 05:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:52 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 05:50:52 INFO - Cleaning up... 05:50:52 INFO - Return code: 0 05:50:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1d42c64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x118d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121fa50>, '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 0x118b550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118b9e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453726832.279669-280590249', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 05:50:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:50:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:50:52 INFO - Using env: {'DISPLAY': ':0', 05:50:52 INFO - 'HOME': '/home/cltbld', 05:50:52 INFO - 'LANG': 'en_US.UTF-8', 05:50:52 INFO - 'LANGUAGE': 'en_US:en', 05:50:52 INFO - 'LOGNAME': 'cltbld', 05:50:52 INFO - 'MAIL': '/var/mail/cltbld', 05:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:52 INFO - 'MOZ_NO_REMOTE': '1', 05:50:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:52 INFO - 'NO_EM_RESTART': '1', 05:50:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:50:52 INFO - 'PWD': '/builds/slave/test-pgo', 05:50:52 INFO - 'SHELL': '/bin/bash', 05:50:52 INFO - 'SHLVL': '1', 05:50:52 INFO - 'TERM': 'linux', 05:50:52 INFO - 'TMOUT': '86400', 05:50:52 INFO - 'USER': 'cltbld', 05:50:52 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453726832.279669-280590249', 05:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:52 INFO - '_': '/tools/buildbot/bin/python'} 05:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:52 INFO - Downloading/unpacking psutil>=0.7.1 05:50: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 05:50: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 05:50: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 05:50: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 05:50: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 05:50: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 05:50:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:50:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:50:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:50:54 INFO - Installing collected packages: psutil 05:50:54 INFO - Running setup.py install for psutil 05:50:54 INFO - building 'psutil._psutil_linux' extension 05:50:54 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 05:50:54 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 05:50:54 INFO - building 'psutil._psutil_posix' extension 05:50:54 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 05:50:55 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 05:50:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:50:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:50:55 INFO - Successfully installed psutil 05:50:55 INFO - Cleaning up... 05:50:55 INFO - Return code: 0 05:50:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:50:55 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')]} 05:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:55 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')]} 05:50:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1d42c64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x118d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121fa50>, '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 0x118b550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118b9e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453726832.279669-280590249', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 05:50:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:50:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:50:55 INFO - Using env: {'DISPLAY': ':0', 05:50:55 INFO - 'HOME': '/home/cltbld', 05:50:55 INFO - 'LANG': 'en_US.UTF-8', 05:50:55 INFO - 'LANGUAGE': 'en_US:en', 05:50:55 INFO - 'LOGNAME': 'cltbld', 05:50:55 INFO - 'MAIL': '/var/mail/cltbld', 05:50:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:55 INFO - 'MOZ_NO_REMOTE': '1', 05:50:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:55 INFO - 'NO_EM_RESTART': '1', 05:50:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:50:55 INFO - 'PWD': '/builds/slave/test-pgo', 05:50:55 INFO - 'SHELL': '/bin/bash', 05:50:55 INFO - 'SHLVL': '1', 05:50:55 INFO - 'TERM': 'linux', 05:50:55 INFO - 'TMOUT': '86400', 05:50:55 INFO - 'USER': 'cltbld', 05:50:55 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453726832.279669-280590249', 05:50:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:55 INFO - '_': '/tools/buildbot/bin/python'} 05:50:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:50:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:50:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:50:57 INFO - Installing collected packages: mozsystemmonitor 05:50:57 INFO - Running setup.py install for mozsystemmonitor 05:50:57 INFO - Successfully installed mozsystemmonitor 05:50:57 INFO - Cleaning up... 05:50:57 INFO - Return code: 0 05:50:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1d42c64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x118d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121fa50>, '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 0x118b550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118b9e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453726832.279669-280590249', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 05:50:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:50:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:50:57 INFO - Using env: {'DISPLAY': ':0', 05:50:57 INFO - 'HOME': '/home/cltbld', 05:50:57 INFO - 'LANG': 'en_US.UTF-8', 05:50:57 INFO - 'LANGUAGE': 'en_US:en', 05:50:57 INFO - 'LOGNAME': 'cltbld', 05:50:57 INFO - 'MAIL': '/var/mail/cltbld', 05:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:57 INFO - 'MOZ_NO_REMOTE': '1', 05:50:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:57 INFO - 'NO_EM_RESTART': '1', 05:50:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:50:57 INFO - 'PWD': '/builds/slave/test-pgo', 05:50:57 INFO - 'SHELL': '/bin/bash', 05:50:57 INFO - 'SHLVL': '1', 05:50:57 INFO - 'TERM': 'linux', 05:50:57 INFO - 'TMOUT': '86400', 05:50:57 INFO - 'USER': 'cltbld', 05:50:57 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453726832.279669-280590249', 05:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:57 INFO - '_': '/tools/buildbot/bin/python'} 05:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:57 INFO - Downloading/unpacking blobuploader==1.2.4 05:50:57 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 05:50:57 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 05:50:57 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 05:50:57 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 05:50:57 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 05:50:57 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 05:50:59 INFO - Downloading blobuploader-1.2.4.tar.gz 05:50:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:50:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:50:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:00 INFO - Downloading docopt-0.6.1.tar.gz 05:51:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:51:00 INFO - Installing collected packages: blobuploader, requests, docopt 05:51:00 INFO - Running setup.py install for blobuploader 05:51:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:51:00 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:51:00 INFO - Running setup.py install for requests 05:51:00 INFO - Running setup.py install for docopt 05:51:00 INFO - Successfully installed blobuploader requests docopt 05:51:00 INFO - Cleaning up... 05:51:00 INFO - Return code: 0 05:51:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:51:00 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')]} 05:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:00 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')]} 05:51:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7f1d42c64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x118d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121fa50>, '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 0x118b550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118b9e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453726832.279669-280590249', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 05:51:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/config 05:51:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/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 05:51:00 INFO - Using env: {'DISPLAY': ':0', 05:51:00 INFO - 'HOME': '/home/cltbld', 05:51:00 INFO - 'LANG': 'en_US.UTF-8', 05:51:00 INFO - 'LANGUAGE': 'en_US:en', 05:51:00 INFO - 'LOGNAME': 'cltbld', 05:51:00 INFO - 'MAIL': '/var/mail/cltbld', 05:51:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:00 INFO - 'MOZ_NO_REMOTE': '1', 05:51:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:00 INFO - 'NO_EM_RESTART': '1', 05:51:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:51:00 INFO - 'PWD': '/builds/slave/test-pgo', 05:51:00 INFO - 'SHELL': '/bin/bash', 05:51:00 INFO - 'SHLVL': '1', 05:51:00 INFO - 'TERM': 'linux', 05:51:00 INFO - 'TMOUT': '86400', 05:51:00 INFO - 'USER': 'cltbld', 05:51:00 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453726832.279669-280590249', 05:51:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:00 INFO - '_': '/tools/buildbot/bin/python'} 05:51:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:51:00 INFO - Running setup.py (path:/tmp/pip-u3rWb5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:51:01 INFO - Running setup.py (path:/tmp/pip-uBhv65-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:51:01 INFO - Running setup.py (path:/tmp/pip-attcLy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:51:01 INFO - Running setup.py (path:/tmp/pip-nsmreI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:51:01 INFO - Running setup.py (path:/tmp/pip-TBMyKi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:51:01 INFO - Running setup.py (path:/tmp/pip-D97m_Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:51:01 INFO - Running setup.py (path:/tmp/pip-tp3oXg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:51:01 INFO - Running setup.py (path:/tmp/pip-ZuKD3L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:51:01 INFO - Running setup.py (path:/tmp/pip-sClWpi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:51:01 INFO - Running setup.py (path:/tmp/pip-geO92C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:51:01 INFO - Running setup.py (path:/tmp/pip-VlKqif-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:51:01 INFO - Running setup.py (path:/tmp/pip-4emBxf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:51:01 INFO - Running setup.py (path:/tmp/pip-jAxVwj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:51:01 INFO - Running setup.py (path:/tmp/pip-lazlV6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:51:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:51:01 INFO - Running setup.py (path:/tmp/pip-0xZSr1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:51:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:51:02 INFO - Running setup.py (path:/tmp/pip-DQP3HC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:51:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:51:02 INFO - Running setup.py (path:/tmp/pip-eRTx9J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:51:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:51:02 INFO - Running setup.py install for manifestparser 05:51:02 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:51:02 INFO - Running setup.py install for mozcrash 05:51:02 INFO - Running setup.py install for mozdebug 05:51:02 INFO - Running setup.py install for mozdevice 05:51:02 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:51:02 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:51:02 INFO - Running setup.py install for mozfile 05:51:02 INFO - Running setup.py install for mozhttpd 05:51:02 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:51:02 INFO - Running setup.py install for mozinfo 05:51:02 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:51:02 INFO - Running setup.py install for mozInstall 05:51:03 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:51:03 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:51:03 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:51:03 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:51:03 INFO - Running setup.py install for mozleak 05:51:03 INFO - Running setup.py install for mozlog 05:51:03 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:51:03 INFO - Running setup.py install for moznetwork 05:51:03 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:51:03 INFO - Running setup.py install for mozprocess 05:51:03 INFO - Running setup.py install for mozprofile 05:51:03 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:51:03 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:51:03 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:51:03 INFO - Running setup.py install for mozrunner 05:51:03 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:51:03 INFO - Running setup.py install for mozscreenshot 05:51:03 INFO - Running setup.py install for moztest 05:51:03 INFO - Running setup.py install for mozversion 05:51:03 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:51:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:51:03 INFO - Cleaning up... 05:51:04 INFO - Return code: 0 05:51:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:51:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7f1d42c64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x118d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121fa50>, '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 0x118b550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118b9e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453726832.279669-280590249', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 05:51:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/config 05:51:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/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 05:51:04 INFO - Using env: {'DISPLAY': ':0', 05:51:04 INFO - 'HOME': '/home/cltbld', 05:51:04 INFO - 'LANG': 'en_US.UTF-8', 05:51:04 INFO - 'LANGUAGE': 'en_US:en', 05:51:04 INFO - 'LOGNAME': 'cltbld', 05:51:04 INFO - 'MAIL': '/var/mail/cltbld', 05:51:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:04 INFO - 'MOZ_NO_REMOTE': '1', 05:51:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:04 INFO - 'NO_EM_RESTART': '1', 05:51:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:51:04 INFO - 'PWD': '/builds/slave/test-pgo', 05:51:04 INFO - 'SHELL': '/bin/bash', 05:51:04 INFO - 'SHLVL': '1', 05:51:04 INFO - 'TERM': 'linux', 05:51:04 INFO - 'TMOUT': '86400', 05:51:04 INFO - 'USER': 'cltbld', 05:51:04 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453726832.279669-280590249', 05:51:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:04 INFO - '_': '/tools/buildbot/bin/python'} 05:51:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:51:04 INFO - Running setup.py (path:/tmp/pip-hZQT2M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:51:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:51:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:51:04 INFO - Running setup.py (path:/tmp/pip-fa48xr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:51:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:51:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:51:04 INFO - Running setup.py (path:/tmp/pip-9Qz9kJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:51:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:51:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:51:04 INFO - Running setup.py (path:/tmp/pip-EQ6gNF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:51:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:51:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:51:04 INFO - Running setup.py (path:/tmp/pip-aC4GF0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:51:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:51:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:51:04 INFO - Running setup.py (path:/tmp/pip-nbHSJ1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:51:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:51:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:51:04 INFO - Running setup.py (path:/tmp/pip-yoCWlY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:51:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:51:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:51:04 INFO - Running setup.py (path:/tmp/pip-tluA8J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:51:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:51:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:51:04 INFO - Running setup.py (path:/tmp/pip-tJqC6Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:51:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:51:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:51:04 INFO - Running setup.py (path:/tmp/pip-R_yJd4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:51:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:51:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:51:04 INFO - Running setup.py (path:/tmp/pip-xmBkVW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:51:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:51:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:51:05 INFO - Running setup.py (path:/tmp/pip-ete33v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:51:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:51:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:51:05 INFO - Running setup.py (path:/tmp/pip-L0cvxH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:51:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:51:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:51:05 INFO - Running setup.py (path:/tmp/pip-ZGPY5X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:51:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:51:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:51:05 INFO - Running setup.py (path:/tmp/pip-7Ylhsi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:51:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:51:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:51:05 INFO - Running setup.py (path:/tmp/pip-c7fdrx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:51:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:51:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:51:05 INFO - Running setup.py (path:/tmp/pip-DbEdEj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:51:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:51:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:51:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:51:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:51:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:51:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:51:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:07 INFO - Downloading blessings-1.6.tar.gz 05:51:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:51:07 INFO - Installing collected packages: blessings 05:51:07 INFO - Running setup.py install for blessings 05:51:07 INFO - Successfully installed blessings 05:51:07 INFO - Cleaning up... 05:51:07 INFO - Return code: 0 05:51:07 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:51:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:51:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:51:07 INFO - Reading from file tmpfile_stdout 05:51:07 INFO - Current package versions: 05:51:07 INFO - argparse == 1.2.1 05:51:07 INFO - blessings == 1.6 05:51:07 INFO - blobuploader == 1.2.4 05:51:07 INFO - docopt == 0.6.1 05:51:07 INFO - manifestparser == 1.1 05:51:07 INFO - mozInstall == 1.12 05:51:07 INFO - mozcrash == 0.16 05:51:07 INFO - mozdebug == 0.1 05:51:07 INFO - mozdevice == 0.47 05:51:07 INFO - mozfile == 1.2 05:51:07 INFO - mozhttpd == 0.7 05:51:07 INFO - mozinfo == 0.9 05:51:07 INFO - mozleak == 0.1 05:51:07 INFO - mozlog == 3.1 05:51:07 INFO - moznetwork == 0.27 05:51:07 INFO - mozprocess == 0.22 05:51:07 INFO - mozprofile == 0.27 05:51:07 INFO - mozrunner == 6.11 05:51:07 INFO - mozscreenshot == 0.1 05:51:07 INFO - mozsystemmonitor == 0.0 05:51:07 INFO - moztest == 0.7 05:51:07 INFO - mozversion == 1.4 05:51:07 INFO - psutil == 3.1.1 05:51:07 INFO - requests == 1.2.3 05:51:07 INFO - wsgiref == 0.1.2 05:51:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7f1d42c64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x118d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121fa50>, '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 0x118b550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118b9e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453726832.279669-280590249', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 05:51:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/talos 05:51:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/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 05:51:07 INFO - Using env: {'DISPLAY': ':0', 05:51:07 INFO - 'HOME': '/home/cltbld', 05:51:07 INFO - 'LANG': 'en_US.UTF-8', 05:51:07 INFO - 'LANGUAGE': 'en_US:en', 05:51:07 INFO - 'LOGNAME': 'cltbld', 05:51:07 INFO - 'MAIL': '/var/mail/cltbld', 05:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:07 INFO - 'MOZ_NO_REMOTE': '1', 05:51:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:07 INFO - 'NO_EM_RESTART': '1', 05:51:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:51:07 INFO - 'PWD': '/builds/slave/test-pgo', 05:51:07 INFO - 'SHELL': '/bin/bash', 05:51:07 INFO - 'SHLVL': '1', 05:51:07 INFO - 'TERM': 'linux', 05:51:07 INFO - 'TMOUT': '86400', 05:51:07 INFO - 'USER': 'cltbld', 05:51:07 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453726832.279669-280590249', 05:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:07 INFO - '_': '/tools/buildbot/bin/python'} 05:51:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:51:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:51:07 INFO - Cleaning up... 05:51:07 INFO - Return code: 0 05:51:07 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1d42c64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x118d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121fa50>, '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 0x118b550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118b9e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453726832.279669-280590249', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 05:51:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:51:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:51:07 INFO - Using env: {'DISPLAY': ':0', 05:51:07 INFO - 'HOME': '/home/cltbld', 05:51:07 INFO - 'LANG': 'en_US.UTF-8', 05:51:07 INFO - 'LANGUAGE': 'en_US:en', 05:51:07 INFO - 'LOGNAME': 'cltbld', 05:51:07 INFO - 'MAIL': '/var/mail/cltbld', 05:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:07 INFO - 'MOZ_NO_REMOTE': '1', 05:51:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:07 INFO - 'NO_EM_RESTART': '1', 05:51:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:51:07 INFO - 'PWD': '/builds/slave/test-pgo', 05:51:07 INFO - 'SHELL': '/bin/bash', 05:51:07 INFO - 'SHLVL': '1', 05:51:07 INFO - 'TERM': 'linux', 05:51:07 INFO - 'TMOUT': '86400', 05:51:07 INFO - 'USER': 'cltbld', 05:51:07 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453726832.279669-280590249', 05:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:07 INFO - '_': '/tools/buildbot/bin/python'} 05:51:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:08 INFO - Downloading/unpacking jsonschema 05:51:08 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 05:51:08 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 05:51:08 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 05:51:08 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 05:51:08 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 05:51:08 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 05:51:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:51:09 INFO - Downloading/unpacking functools32 (from jsonschema) 05:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:10 INFO - Downloading functools32-3.2.3-2.tar.gz 05:51:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:51:10 INFO - warning: no files found matching '*.txt' 05:51:10 INFO - no previously-included directories found matching 'build' 05:51:10 INFO - no previously-included directories found matching 'dist' 05:51:10 INFO - no previously-included directories found matching '.git*' 05:51:10 INFO - Installing collected packages: jsonschema, functools32 05:51:10 INFO - Running setup.py install for functools32 05:51:10 INFO - warning: no files found matching '*.txt' 05:51:10 INFO - no previously-included directories found matching 'build' 05:51:10 INFO - no previously-included directories found matching 'dist' 05:51:10 INFO - no previously-included directories found matching '.git*' 05:51:10 INFO - Successfully installed jsonschema functools32 05:51:10 INFO - Cleaning up... 05:51:10 INFO - Return code: 0 05:51:10 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:51:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1d42c64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x118d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121fa50>, '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 0x118b550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118b9e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453726832.279669-280590249', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 05:51:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 05:51:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:51:10 INFO - Using env: {'DISPLAY': ':0', 05:51:10 INFO - 'HOME': '/home/cltbld', 05:51:10 INFO - 'LANG': 'en_US.UTF-8', 05:51:10 INFO - 'LANGUAGE': 'en_US:en', 05:51:10 INFO - 'LOGNAME': 'cltbld', 05:51:10 INFO - 'MAIL': '/var/mail/cltbld', 05:51:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:10 INFO - 'MOZ_NO_REMOTE': '1', 05:51:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:10 INFO - 'NO_EM_RESTART': '1', 05:51:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:51:10 INFO - 'PWD': '/builds/slave/test-pgo', 05:51:10 INFO - 'SHELL': '/bin/bash', 05:51:10 INFO - 'SHLVL': '1', 05:51:10 INFO - 'TERM': 'linux', 05:51:10 INFO - 'TMOUT': '86400', 05:51:10 INFO - 'USER': 'cltbld', 05:51:10 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453726832.279669-280590249', 05:51:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:10 INFO - '_': '/tools/buildbot/bin/python'} 05:51:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:10 INFO - Downloading/unpacking flake8 05:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:51:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:51:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:51:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:51:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:51:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:51:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:51:12 INFO - no previously-included directories found matching 'docs/_build' 05:51:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:51:13 INFO - Running setup.py install for pep8 05:51:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:51:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:51:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:51:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:51:13 INFO - no previously-included directories found matching 'docs/_build' 05:51:13 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:51:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:51:13 INFO - Cleaning up... 05:51:13 INFO - Return code: 0 05:51:13 INFO - Running post-action listener: _resource_record_post_action 05:51:13 INFO - Running post-action listener: _start_resource_monitoring 05:51:13 INFO - Starting resource monitoring. 05:51:13 INFO - ##### 05:51:13 INFO - ##### Running install step. 05:51:13 INFO - ##### 05:51:13 INFO - Running pre-action listener: _resource_record_pre_action 05:51:13 INFO - Running main action method: install 05:51:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:51:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:51:13 INFO - Reading from file tmpfile_stdout 05:51:13 INFO - Detecting whether we're running mozinstall >=1.0... 05:51:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:51:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:51:13 INFO - Reading from file tmpfile_stdout 05:51:13 INFO - Output received: 05:51:13 INFO - Usage: mozinstall [options] installer 05:51:13 INFO - Options: 05:51:13 INFO - -h, --help show this help message and exit 05:51:13 INFO - -d DEST, --destination=DEST 05:51:13 INFO - Directory to install application into. [default: 05:51:13 INFO - "/builds/slave/test-pgo"] 05:51:13 INFO - --app=APP Application being installed. [default: firefox] 05:51:13 INFO - mkdir: /builds/slave/test-pgo/build/application 05:51:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:51:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:51:28 INFO - Reading from file tmpfile_stdout 05:51:28 INFO - Output received: 05:51:28 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:51:28 INFO - Running post-action listener: _resource_record_post_action 05:51:28 INFO - ##### 05:51:28 INFO - ##### Running run-tests step. 05:51:28 INFO - ##### 05:51:28 INFO - Running pre-action listener: _resource_record_pre_action 05:51:28 INFO - Running main action method: run_tests 05:51:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:51:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:51:28 INFO - Python 2.7.3 05:51:28 INFO - Return code: 0 05:51:28 INFO - grabbing minidump binary from tooltool 05:51:28 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')]} 05:51:28 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-pgo/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 0x121fa50>, '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 0x118b550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118b9e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:51:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:51:28 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:51:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:51:28 INFO - Return code: 0 05:51:28 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:51:28 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:51:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:51:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:51:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:51:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:51:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:51:29 INFO - Return code: 0 05:51:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/pgZ1QC9cScidWMmi6Xh3Pg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 05:51:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/pgZ1QC9cScidWMmi6Xh3Pg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost 05:51:29 INFO - Using env: {'DISPLAY': ':0', 05:51:29 INFO - 'HOME': '/home/cltbld', 05:51:29 INFO - 'LANG': 'en_US.UTF-8', 05:51:29 INFO - 'LANGUAGE': 'en_US:en', 05:51:29 INFO - 'LOGNAME': 'cltbld', 05:51:29 INFO - 'MAIL': '/var/mail/cltbld', 05:51:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:51:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:29 INFO - 'MOZ_NO_REMOTE': '1', 05:51:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:51:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:29 INFO - 'NO_EM_RESTART': '1', 05:51:29 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:51:29 INFO - 'PWD': '/builds/slave/test-pgo', 05:51:29 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:51:29 INFO - 'SHELL': '/bin/bash', 05:51:29 INFO - 'SHLVL': '1', 05:51:29 INFO - 'TERM': 'linux', 05:51:29 INFO - 'TMOUT': '86400', 05:51:29 INFO - 'USER': 'cltbld', 05:51:29 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453726832.279669-280590249', 05:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:29 INFO - '_': '/tools/buildbot/bin/python'} 05:51:29 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/pgZ1QC9cScidWMmi6Xh3Pg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost'] with output_timeout 3600 05:51:29 INFO - mozversion INFO | application_buildid: 20160125031008 05:51:29 INFO - mozversion INFO | application_changeset: 97e6ca995311c2ea072e492021049a68fa5d19b1 05:51:29 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 05:51:29 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:51:29 INFO - mozversion INFO | application_name: Firefox 05:51:29 INFO - mozversion INFO | application_remotingname: firefox-dev 05:51:29 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:51:29 INFO - mozversion INFO | application_vendor: Mozilla 05:51:29 INFO - mozversion INFO | application_version: 45.0a2 05:51:29 INFO - mozversion INFO | platform_buildid: 20160125031008 05:51:29 INFO - mozversion INFO | platform_changeset: 97e6ca995311c2ea072e492021049a68fa5d19b1 05:51:29 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:51:29 INFO - mozversion INFO | platform_version: 45.0a2 05:51:29 INFO - 2016-01-25 05:51:29,496 DEBUG : using testdate: 1453729889 05:51:29 INFO - 2016-01-25 05:51:29,497 DEBUG : actual date: 1453729889 05:51:29 INFO - 2016-01-25 05:51:29,506 INFO : starting webserver on 'localhost:51944' 05:51:29 INFO - 2016-01-25 05:51:29,507 INFO : Starting test suite talos-linux64-ix-067.e 05:51:29 INFO - 2016-01-25 05:51:29,507 INFO : Starting test dromaeo_css 05:51:29 INFO - 2016-01-25 05:51:29,508 DEBUG : operating with platform_type : linux_ 05:51:29 INFO - 2016-01-25 05:51:29,508 INFO : Initialising browser for dromaeo_css test... 05:51:29 INFO - 2016-01-25 05:51:29,522 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfOrt1W/profile http://localhost:51944/getInfo.html 05:51:32 INFO - 2016-01-25 05:51:32,804 DEBUG : BROWSER_OUTPUT: 05:51:32 INFO - 2016-01-25 05:51:32,804 DEBUG : BROWSER_OUTPUT: (process:21748): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:51:33 INFO - 2016-01-25 05:51:33,594 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:51:33 INFO - 2016-01-25 05:51:33,594 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:51:33 INFO - 2016-01-25 05:51:33,594 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:51:33 INFO - 2016-01-25 05:51:33,594 DEBUG : BROWSER_OUTPUT: __metrics 05:51:34 INFO - 2016-01-25 05:51:34,564 INFO : Browser initialized. 05:51:34 INFO - 2016-01-25 05:51:34,565 INFO : Running cycle 1/1 for dromaeo_css test... 05:51:34 INFO - 2016-01-25 05:51:34,565 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfOrt1W/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:51:35 INFO - 2016-01-25 05:51:35,856 DEBUG : BROWSER_OUTPUT: 05:51:35 INFO - 2016-01-25 05:51:35,857 DEBUG : BROWSER_OUTPUT: (process:21861): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:51:46 INFO - 2016-01-25 05:51:46,362 DEBUG : BROWSER_OUTPUT: RSS: Main: 136400896 05:51:46 INFO - 2016-01-25 05:51:46,363 DEBUG : BROWSER_OUTPUT: 05:52:35 INFO - 2016-01-25 05:52:35,986 DEBUG : BROWSER_OUTPUT: 1453729955985 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] 05:54:44 INFO - 2016-01-25 05:54:44,502 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51944/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51944/tests/dromaeo/cssquery-ext.html) 05:54:45 INFO - 2016-01-25 05:54:45,548 DEBUG : BROWSER_OUTPUT: RSS: Main: 141254656 05:54:45 INFO - 2016-01-25 05:54:45,549 DEBUG : BROWSER_OUTPUT: 05:57:47 INFO - 2016-01-25 05:57:47,270 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51944/tests/dromaeo/cssquery-ext.html (next: http://localhost:51944/tests/dromaeo/cssquery-jquery.html) 05:57:47 INFO - 2016-01-25 05:57:47,857 DEBUG : BROWSER_OUTPUT: RSS: Main: 140251136 05:57:47 INFO - 2016-01-25 05:57:47,857 DEBUG : BROWSER_OUTPUT: 06:00:49 INFO - 2016-01-25 06:00:49,399 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51944/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51944/tests/dromaeo/cssquery-mootools.html) 06:00:49 INFO - 2016-01-25 06:00:49,988 DEBUG : BROWSER_OUTPUT: RSS: Main: 139116544 06:00:49 INFO - 2016-01-25 06:00:49,989 DEBUG : BROWSER_OUTPUT: 06:03:51 INFO - 2016-01-25 06:03:51,532 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51944/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51944/tests/dromaeo/cssquery-prototype.html) 06:03:52 INFO - 2016-01-25 06:03:52,126 DEBUG : BROWSER_OUTPUT: RSS: Main: 139657216 06:03:52 INFO - 2016-01-25 06:03:52,126 DEBUG : BROWSER_OUTPUT: 06:06:54 INFO - 2016-01-25 06:06:54,328 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51944/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51944/tests/dromaeo/cssquery-yui.html) 06:06:54 INFO - 2016-01-25 06:06:54,918 DEBUG : BROWSER_OUTPUT: RSS: Main: 139853824 06:06:54 INFO - 2016-01-25 06:06:54,919 DEBUG : BROWSER_OUTPUT: 06:09:57 INFO - 2016-01-25 06:09:57,013 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51944/tests/dromaeo/cssquery-yui.html (next: http://localhost:51944/tests/dromaeo/cssquery-dojo.html) 06:09:57 INFO - 2016-01-25 06:09:57,271 DEBUG : BROWSER_OUTPUT: RSS: Main: 142045184 06:09:57 INFO - 2016-01-25 06:09:57,272 DEBUG : BROWSER_OUTPUT: 06:09:57 INFO - 2016-01-25 06:09:57,272 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:09:57 INFO - 2016-01-25 06:09:57,273 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:09:57 INFO - 2016-01-25 06:09:57,273 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:09:57 INFO - 2016-01-25 06:09:57,273 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:09:57 INFO - 2016-01-25 06:09:57,273 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3331.3836940166066;3438.106092415971;3457.1011537000372;3472.357613841438;3481.2863363010583;5472.945270547293;5579.38626751057;5596.4123767004485;5611.158326251059;5612.635178713386;5599.524040456566;5710.7430165642545;5724.62789918656;5753.856153596152;5754.453326933945;5168.043911876315;5218.869528261805;5246.5802735781235;5273.841784746463;5277.050130976423;5072.923906141411;5087.364079490064;5187.610929180308;5206.869828254286;5209.7134657593815;5120.15517439622;5216.478352164772;5232.895342093156;5236.083685355066;5250.868728281805;5210.76551555181;5286.7885284588765;5297.682139071668;5301.363836339664;5328.333958255218;4977;5032.572231360339;5042.470540593258;5136.126858434075;5174.456682048406;5451.754671039813;5481.588880833913;5495.477929596682;5530.972345138249;5563.471470210324;6190.473809726133;6194.473469755077;6194.783182588588;6207.534434917354;6215.06773983906;5884.470397664188;6000.429959153874;6006.579539432241;6009.669468179249;6245.063240513914;5661.2357331760095;5717.514011309002;5746.367899531048;5755.338136114358;5782.595218334718;6201.534884883652;6257.843553911189;6257.874842503215;6262.091996660459;6273.466755325757;5947.256592925884;5986.4013598639785;6018.398160184034;6066.120412540157;6080.391960803884;6105.603135796159;6142.447179753844;6150.292716337678;6205.069239614094;6224.502039836802;6109.663968481687;6135.9079613805825;6164.075388691732;6168.722407491674;6189.876202475925;5739.024365857731;5849.7952571660635;5959.344472108065;6070.3929607038945;6089.512838972872;4668.533146685304;4699.389079419653;4709.175894218498;4710.764461776897;4731.858044258678;4227.112306415687;4229.555896630809;4232.576742325743;4235.555266697014;4249.553796851348;5660.066089095253;5711.485966263056;5780.306363236438;5821.446962538552;5825.2135961644635;6206.565540412218;6247.187865577446;6266.342034086447;6276.529260305495;6312.368763123651;5604.8318550443555;5878.735456904449;5896.823095307148;5902.3507414184405;5905.291365036223;5028.949710502849;5132.948670513247;5145.871353216199;5156.716380599103;5173.689578625294;6313.810585682437;6318.273398559132;6318.431341179224;6321.96839015802;6353.904691429632;5832.825015249549;5941.643501389931;6226.439620434183;6229.56393052482;6244.313125556095;6174.073888916699;6332;6336.651484168415;6343.080253363144;6346.238451385863;6052.364501727431;6065.4541091302;6102.4812890902995;6134.171886795226;6134.35589263121;5939.316978547522;5982.102684597346;6110.480609148272;6156.476699480415;6226.470749986302;5983.491403230774;6008.339082700812;6012.338642749207;6013.789517366871;6037.486813620892;5943.64338139713;5981.820545383645;5984.072468767348;5994.550408719277;6002.159697642246;5655.575831812548;5729.942700572941;5753.3958934311295;5908.615939963888;5917;6007.789727359522;6097.451229389376;6103.511719062376;6135.785247516315;6136.8772624548155;5892.734826932884;5975.312839023568;5986;5987.371326010706;6000.69996500182 06:09:57 INFO - 2016-01-25 06:09:57,274 DEBUG : BROWSER_OUTPUT: |1;ext.html;598.9011813050844;641.0576452614656;648.575183254968;662.5693299355421;676.489250615785;32815.50776738351;41789.373159402596;41829;41903.37144942828;42000.369994450106;45931.311030334575;46413;46545.53454465454;46571.534284657144;46575.534244657545;9002.954985225064;9069.773255668595;9084.954575227115;9141.634334626608;9160.35877488576;8924.062973387798;9034.232090272302;9043.638254469814;9049.909500904972;9058.773530661752;9013.684521041765;9035.277177825757;9098.408603440788;9110.681126160585;9142.040085790995;8959.865602015974;8983.685571004984;9059.048799876049;9060.728178154633;9063.320250981169;8923.776905577348;9057.592408341641;9072.637094516278;9082.954585227031;9098;40728;41130.79434602808;41143;41225;41314.586854131376;3544.769589976643;3566.3937130687846;3572.464130380438;3610.6930910872607;3625.075605720551;31148.844255778804;31672.841635791905;31852.522212166838;32175;32581.674183258103;4136.607022332873;4151.12826306476;4171.478565179353;4172.332426811696;4244.469441319835;272179;273595.8960615592;273791;273944;274088;45522.317165242544;45622.31566526505;45970;46038;46050.30924536135;43485;43535.56464435315;43566;43575;43637.78181109074;15971.760423593656;16056;16066.75899861503;16113.194340282938;16136.031838089517;12333.876661233453;12393.690157746129;12405.875941240472;12546.68633284157;12799.232046077264;15320.463783767515;15375.538733838002;15493.612659683373;15534.766978495332;15650.843491564938;5938.940610593925;6030.577859549877;6059.515238780887;6074.179985701962;6112.327643959161;1091.8853520380405;1148.9716703550444;1156.7455159864817;1158.0735411670798;1199.1306302930307;29560;29587.26031849178;29692.554611680844;29925.10224693219;30231.244218894702;1120.0871289898707;1130.37829193943;1146.146096220422;1197.3354788092518;1227.877212278765;15242.542723718307;15343.53969380898;15354.232288385536;15624.375024998873;15803.762943555856;529108;536697;538351;539495;540409;57939.13091303634;59082;59153;59203.407965920655;59377.70311148417;1508.6907184027248;1535.4165417141414;1539.6150962259435;1541.8381069987713;1544.0658401667279;31138.377232455678;31694.683053170094;31833.36333273275;32014;32407;50985.7450712744;51117.48882511276;51152.48847511477;51224.23163652474;51631;319952;323604;323788;323880;323932;35355.82322088373;35708.64291357053;35954.64045359513;36016.819915900254;36025.81987090048;46572.30141547947;47071.52928470672;47297.29054064123;47374.763126184145;47618.285725714835;39625.40561891516;39800;39821.60178398179;39859;40902.795486022376;38993.22013559656;39021;39164.6083539161;39286.607133929436;39899;38605.806970964964;38618;39632.60367396405;39671.2065758689;39706.60293397029;34108.31783364269;34373.82813085918;34748.65251347555;34761.478577820846;34827.82586087054;26775.86612066927;27309.180724577498;27427.588586171623;27481.31296717598;27528.862355688092 06:09:57 INFO - 2016-01-25 06:09:57,274 DEBUG : BROWSER_OUTPUT: |2;jquery.html;389.2215568862275;392.1607759394894;392.26646171658996;394.1466724541368;396.6331143692084;16184.83815161848;16640.167991600432;17976.191071401787;20394.490137746565;20451;11489.942550287236;12167.391630418466;14069.437222511113;17710.291588336484;17841.553961150978;4454.265046267362;5117.718525481087;5248.976449592331;5737.225474560943;5762.308522977249;5664.943350566504;5732.283464566929;5753.597248192628;5762.4525670061275;5766.913496297559;5591.189277554772;5660.518855897254;5663.0655941769555;5666.433356664342;5724.513416359614;5603.299587551556;5611.494965453108;5615.129654903476;5648.774049038034;5651.2370829938045;5049.2173713074535;5068.960863023109;5197.896042079137;5209.895802083975;5218.739063046833;13051.738965220737;13533.188008719508;16693.248803803857;19781.109850056782;20364.79635203644;2070.5030792609814;2080.937571872846;2143.6248656485054;2193.6270833958265;2251.9190788421483;9903.108720215216;9937.205023598095;9951.601935922554;9982.051705088004;10113.89886101137;1843.9815601843943;1867.6638205123072;1876.1463534091956;1913.7607799025122;2012.9899350503301;58561.41438585645;58593;58910;62364.68817655928;65982.67008664926;10157.644482443078;10724.088452481627;10965.56137754481;11038.558457661764;11109.055730262857;14136.444991050976;14187.503437379848;14419.35112919921;14432;14434.206118663364;8202.753917382488;8224.259816616533;8270.37972152091;8492.532910689848;8531.23218910301;8040.839183216303;8108.716194933149;8138.755837324889;8407.831843363221;8624.827503449897;4540.523245059221;4550.408446901948;4561.29299958507;4641.582257596832;4658.67389282747;1896.3741965151467;1935.6128774245208;1950.882947023183;1962.0189905047475;1966.5083729067733;881.7442941547008;951.0632027452954;964.2719746591279;974.1184228273424;1027.4913917610832;17161.828381716274;17401.56496087608;17627.55931101707;17679.469615911545;17749.645007099785;982.1700662939804;1038.3769738157196;1060.1359891688248;1081.8214994525972;1092.3282181458505;9813.852792208123;9828.754281143028;9933.850992235122;9952.651657191964;10137.543810528545;666391;669385;674944;699401;711509;74973;82280;84553;86370.56814716011;88814.55592721995;1191.7795207886568;1198.083466148397;1210.4915935307192;1227.429245400875;1240.1814802230485;16090.678186435971;16104.275307610951;16181.919090404472;16235.512934611981;16496;37025.444618330206;37454.43818342782;37525.81237093797;37733.81133094427;38767.03082422962;50351.24473132979;50657.74671126768;51227.48772512227;51412;53623.463765363405;9625.422474651543;9953.353032052893;9977.251706121924;10114;10118.494075296352;11396.886031139582;15293.31180096876;15577.37690492413;16780.916095419932;17322.133893305538;14265.42938282457;14555;14590.927045364706;14627.268636568342;15294.847051529343;14771.704565908836;14877.776833347725;14904.850951490347;14929.925350373178;14953;14515.201663908587;14630.634234144232;15621.609459763597;15627.453039143575;16091.839081609034;10326.48367581633;10402.895971040192;10407.21945854079;10415.843762343722;10441.112505436819;14612.415503379745;14840;15063.54809355721;15335.693286134438;15399.3070311834 06:09:57 INFO - 2016-01-25 06:09:57,274 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1572.316042521503;1589.785378973838;1633.3221712989114;1835.3392778599703;1919.5009297582633;7086.822829429267;7274.236205198457;7916.722914697987;8432.283255923247;8439.451435656685;7477.2896574825445;7755.37956963443;7813.843723125548;7821.804454888631;7844.568548729818;2324.523472688099;2363.3500787283465;2364.6689463475127;2368.786809187173;2370.668106465096;2350.2714158610884;2371.3597328721235;2412.95174096518;2425.126954296452;2425.866577338246;2334.7781960713705;2351.5649604823075;2392.0431827269144;2408.301592538162;2417.2144053182697;2348.072511358004;2362.917297894574;2377.156109581091;2380.821438392119;2391.1033362489065;2352.6235802271553;2367.5856725073218;2386.809055275574;2387.0571124405938;2407.65089062085;8163.918360816375;8260.628271727786;8266.090730019692;8295.460795048302;8322.791930201733;4889.633277504201;4957.975210123962;4962;4988.102141614508;4992.301077849104;3189.681031896792;3190.808551486918;3226.6450690424035;3265.4122257993554;3280.6063272407464;989.5744829723216;1003.2826529031777;1027.085893554737;1035.0425856083168;1069.0165048155716;11465.484053217542;11469.827952580801;11470.197086203969;11473.426328683616;11498.942505287503;4337.436133302651;4429.867103986886;4450.532694067077;4515.322701594787;4531.207038768268;9737;9769.951150244204;9794.363366381162;9808.21534277256;9813.901860981441;4968.180250258739;4985.853253751585;4998.600111991032;5001.399832020181;5016.297718319438;4381.364702118175;4508.81964721414;4525.434320709911;4535.387722657465;4539.931901021488;3831.233753249361;3831.482749828793;3841.4237864320576;3843.385058390644;3847.8653247136217;1155.6706338693432;1160.6808127764932;1166.722438929371;1167.1654766841748;1174.7004513848915;1379.2620947792882;1385.7020740540831;1392.4987004678308;1396.3297617143626;1398.1261711430357;7750.573718445539;7940.960295198487;7957.323627491613;7960.363170946311;7963.323117534958;439.8900274931267;442.8671398580413;472.3175012107472;477.5630298277107;478.239599037532;6032.547558933097;6078.300995385499;6081.8479538011015;6083;6089.756409743561;9595.616175353047;10064.949675251723;10090.192784577217;10178.287519873538;10226.488675566341;9927.751806204902;9967.80064398708;9972.252081093948;10016.14862736661;10025.448600327052;7416.517926334771;7607.391408687292;7608.885866712004;7628.084629844343;7635.656395462218;7520.323170914644;7536.284053014955;7569.772906812805;7572;7607.847843043219;8458.450200736932;8729.956350218208;8791.824163516821;8818.867716984121;8824.867626985471;8647.178518040777;8834.911650883409;8965.148310910454;9091.409058411447;9095.317851161057;6989.545679530815;7346.11846578414;7406.333429991327;7515.624218788929;7532.585707786125;8004.83990320202;8019.077806052379;8033.799155021171;8041.437099402986;8082.313003394777;7359.264073592598;7383.889241661272;7479.289467500579;7530.698772049057;7556.697732090654;7231.5299505531975;7347.8163045924275;7378.188399275968;7424.480286379901;7466.066741657293;7574.962125189339;7606.163322034461;7622.390208783395;7623.923760762322;7638.694452221849;6834.658267086526;6866.313368663094;6875.1749790025515;6894.448444124559;6940.27127151662;6928.203256625351;6950.096487456598;6986.196587392515;7036.366726994595;7046.612436315847 06:09:57 INFO - 2016-01-25 06:09:57,278 DEBUG : BROWSER_OUTPUT: |4;prototype.html;357.1303875064218;358.9874354397597;360.877301717416;360.90977255686084;361.8353649089666;6298.212723409574;6360.968195159029;6362.777302794403;6369.681515924202;6418.454431373327;6180.381961803817;6264.96867515663;6344.904826427596;6351;6360.618362898218;4884.291777692241;4898.706077635354;4902.877428064291;4903.9754801225945;4904.681195722284;4896.31451596775;4901.362822833027;4904.75476226189;4905.950940490585;4907.043126590316;4648.279516674921;4811.855644330676;4822.252550854606;4832.516748325174;4843.9515604843855;4760.381150450419;4792.281157826319;4795.4724980252495;4799.5440433158965;4800.759962001904;4157.729747566398;4160.854370097032;4163.562825903297;4170.874873753793;4181.811818468176;5883.7058147092475;5947.226860508106;5954.166416701665;5956.731947062349;5968.432998865101;5562.610617256793;5574.498295153456;5581.107022876361;5585.804496842591;5600.991821472134;6633.2703402625675;6643;6645.767398141042;6649.368310010541;6664.200295964515;4631.16639004979;4632.444106707217;4636.3045543168455;4638.257878739386;4660.487346391894;6761.966190169067;6868.896966545506;6959.512834101615;6961.26906674802;6968.930310696879;4704.670673052853;4721.079389519079;4729.314249433882;4747.382840230748;4750.738709371018;4807.975960120177;4819;4830.589399900978;4842.757862106881;4849.2726091085915;5624.353199382123;5625.943740562542;5628.2683251177905;5636.323641163087;5643.068893632505;6652.966735166293;6819.113515243086;6829.692663830139;6831.59010459374;6835.453163746888;1668.4827703411981;1704.2671651190108;1704.7101992661278;1706.3771723321147;1706.5136436115647;1109.9001089901947;1139.3334899083964;1141.0757286597882;1148.9138314626268;1154.486253617149;6464.612123272619;6481.870362592722;6509.088727578142;6524.249711283168;6535.673216339164;6997.825054373579;6998.125234345707;6999.335063168991;6999.335063169093;7001.719931202695;6408.743650253938;6459.063435801782;6491.870162596816;6502.707378167994;6508.381703738138;3770.6606405423645;3797.734158608926;3800.0309920969976;3800.5439347278502;3805.1818858945458;7132.572045677276;7132.714691412285;7135.1437827459995;7146.2496437874315;7159.427245820322;6987.336203060701;7147.142342918883;7153.105861767279;7157.355837974607;7180.676869540779;7118.537295075804;7143.071400717978;7148.642567871586;7163.247858974837;7177.461690373243;6944.826379340557;6973.651317434006;6976.7558135465015;6993.230744617987;7008.439324853897;6724.562903411263;6858;6883.518153729191;6901.723931042702;6931.930680693128;7123.430125590044;7142.285771423024;7153.499255052305;7174.569525828467;7178.318059784312;4796.784144713426;4798.376211092535;4802.543758342952;4811.831585894477;4814.759262036954;6879.828004299732;6936.583804971718;6984.860302793814;7011.894821577783;7013.158420989514;6737.25890152073;6747.797566073025;6784.5929244243525;6790.049393085071;6810.693518791567;6725.8991115134295;6759.053732477359;6776.593404395752;6786.423154031765;6791.320867913169;6532.8366790830605;6639.634820084749;6666.699998500176;6679.632620205935;6680.630470753581;6741.764038258638;6771.950347696115;6804;6806.047153398429;6809.8638027238185;6586.242582103119;6616.470682345497;6654.933450665431;6658.267590564937;6662.133922590032 06:09:57 INFO - 2016-01-25 06:09:57,278 DEBUG : BROWSER_OUTPUT: |5;yui.html;763.8529259451062;855.4995327733279;900.1133883125125;918.7565295196774;932.9224745419041;13529.458821647135;13953.581392558226;13980.510682126114;14091.859081409182;14156.575302740908;13528.053036287463;15024.098554086762;15085.547433576983;15207.46773862915;15227.314770835339;915.1946287267195;916.5050872528826;927.7680579855037;945.4847108325979;948.4735971535795;931.5435436636068;941.4304345870752;941.9623215071389;943.4527973775229;945.3240932733095;948.6015873333182;964.6816550538306;965.1217392173124;967.1827305926481;970;942.9387089839207;948.4451595816456;951.1059603972244;952.8570714392828;955.1165172215707;711.6619605687309;712;712.2521352579822;714.1822613108014;717.1573401253506;13379.464821407131;13480.05639605228;13484.797728034087;13498.257595832225;13518.391672374766;12242;12680.55618053373;12832.679183020406;12953.417096230693;13834.93082534591;10435.79128417435;10634.30876992993;11386.373749443777;11643.301401915913;11766.588169414115;3818.3317919364276;3856.865009724674;3905.433712111728;3928.4303775952612;3979.283728928792;49900.50099498995;49906;50104;50582.49417505815;50629.746851265874;10317.587296508205;10372.481375931173;10495.947520262349;10536.315139515908;10654.254202205771;19693.507662308555;19699.212031518866;19782.70325945112;20086.899565502077;20096.799032009494;8227.876581851277;8291.08798032216;8325;8366.414350995494;8390.916090839013;4394.758288294174;4405.383246345515;4625.190591646448;4654.16225079489;4696.436427628706;3193.2815116599045;3209.069369882708;3234.1591186291735;3238.3037646906027;3244.8215348156077;553.195101127858;565.8104534980828;571.0891128649797;572.6506830833189;572.7336788393334;725.3798002707714;733.5561984999106;742.1168809117133;742.5322047110286;742.9739959101405;8488.872666910001;8531.658733650584;8567.785805354915;8597.5701214939;8598.78503037429;693.3932808792307;698.8238456216508;726.23019599225;742.7660287009575;745.4371949178444;4150.190712810973;4224.683148763855;4277.401163837066;4301.462317210348;4302.139572085533;63600.68199658972;63724.68137659375;63741.681291593246;64314;64739.67630161913;54090.729546352806;54600.72699636476;55248.72375638096;55571;55821.720891395285;45162.774186129514;45556.77221613871;51783.74108129435;52101.352905297026;52136.99999999924;9245.352825302165;9252.444853308823;9350.503919372868;9561.426314420878;9574.712758617252;38154.80922595369;38680.2263954725;39034;39207.80396098001;39652.60347396489;49760;50153.74923125361;50333.74833125811;50682.493175069256;50801;12408.81386779181;12480.812787808009;12569.183003104768;12580.685482863002;12867.22796632205;13168.144070635379;13332.400041998328;13414.262215577846;13480.393382297623;13995.650108747363;11853;12183.573574925189;12703.745925081632;12807.231566106064;13117.212967221998;11576.305421674726;11587.884121159017;11737.647870563897;11801.40992950332;11871.287722736663;11896.84108084466;11955.342456164646;12147.635570932885;12265.754684906073;12483.875161248634;9974.251931105051;10053.547590358305;10120.291579589359;10129.89870101319;10708.03627673513;9662.613495460384;9739.796605435346;9786.706398808046;9875.506224688594;9905.108540231413 06:09:57 INFO - 2016-01-25 06:09:57,278 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:09:57 INFO - 2016-01-25 06:09:57,278 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:09:57 INFO - 2016-01-25 06:09:57,278 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,318 06:09:57 INFO - 2016-01-25 06:09:57,278 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:09:57 INFO - 2016-01-25 06:09:57,278 DEBUG : BROWSER_OUTPUT: __startTimestamp1453730997264__endTimestamp 06:09:57 INFO - 2016-01-25 06:09:57,279 DEBUG : BROWSER_OUTPUT: 06:09:57 INFO - 2016-01-25 06:09:57,279 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:09:57 INFO - 2016-01-25 06:09:57,279 DEBUG : BROWSER_OUTPUT: Number of tests: 6 06:09:57 INFO - 2016-01-25 06:09:57,279 DEBUG : BROWSER_OUTPUT: 06:09:57 INFO - 2016-01-25 06:09:57,279 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5677.54 Median:5905.29 stddev:637.10 (10.8%) stddev-sans-first:611.89 06:09:57 INFO - 2016-01-25 06:09:57,279 DEBUG : BROWSER_OUTPUT: Values: 3331.4 3438.1 3457.1 3472.4 3481.3 5472.9 5579.4 5596.4 5611.2 5612.6 5599.5 5710.7 5724.6 5753.9 5754.5 5168.0 5218.9 5246.6 5273.8 5277.1 5072.9 5087.4 5187.6 5206.9 5209.7 5120.2 5216.5 5232.9 5236.1 5250.9 5210.8 5286.8 5297.7 5301.4 5328.3 4977.0 5032.6 5042.5 5136.1 5174.5 5451.8 5481.6 5495.5 5531.0 5563.5 6190.5 6194.5 6194.8 6207.5 6215.1 5884.5 6000.4 6006.6 6009.7 6245.1 5661.2 5717.5 5746.4 5755.3 5782.6 6201.5 6257.8 6257.9 6262.1 6273.5 5947.3 5986.4 6018.4 6066.1 6080.4 6105.6 6142.4 6150.3 6205.1 6224.5 6109.7 6135.9 6164.1 6168.7 6189.9 5739.0 5849.8 5959.3 6070.4 6089.5 4668.5 4699.4 4709.2 4710.8 4731.9 4227.1 4229.6 4232.6 4235.6 4249.6 5660.1 5711.5 5780.3 5821.4 5825.2 6206.6 6247.2 6266.3 6276.5 6312.4 5604.8 5878.7 5896.8 5902.4 5905.3 5028.9 5132.9 5145.9 5156.7 5173.7 6313.8 6318.3 6318.4 6322.0 6353.9 5832.8 5941.6 6226.4 6229.6 6244.3 6174.1 6332.0 6336.7 6343.1 6346.2 6052.4 6065.5 6102.5 6134.2 6134.4 5939.3 5982.1 6110.5 6156.5 6226.5 5983.5 6008.3 6012.3 6013.8 6037.5 5943.6 5981.8 5984.1 5994.6 6002.2 5655.6 5729.9 5753.4 5908.6 5917.0 6007.8 6097.5 6103.5 6135.8 6136.9 5892.7 5975.3 5986.0 5987.4 6000.7 06:09:57 INFO - 2016-01-25 06:09:57,279 DEBUG : BROWSER_OUTPUT: 06:09:57 INFO - 2016-01-25 06:09:57,279 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:53902.46 Median:39753.30 stddev:104739.33 (263.5%) stddev-sans-first:104956.69 06:09:57 INFO - 2016-01-25 06:09:57,280 DEBUG : BROWSER_OUTPUT: Values: 598.9 641.1 648.6 662.6 676.5 32815.5 41789.4 41829.0 41903.4 42000.4 45931.3 46413.0 46545.5 46571.5 46575.5 9003.0 9069.8 9085.0 9141.6 9160.4 8924.1 9034.2 9043.6 9049.9 9058.8 9013.7 9035.3 9098.4 9110.7 9142.0 8959.9 8983.7 9059.0 9060.7 9063.3 8923.8 9057.6 9072.6 9083.0 9098.0 40728.0 41130.8 41143.0 41225.0 41314.6 3544.8 3566.4 3572.5 3610.7 3625.1 31148.8 31672.8 31852.5 32175.0 32581.7 4136.6 4151.1 4171.5 4172.3 4244.5 272179.0 273595.9 273791.0 273944.0 274088.0 45522.3 45622.3 45970.0 46038.0 46050.3 43485.0 43535.6 43566.0 43575.0 43637.8 15971.8 16056.0 16066.8 16113.2 16136.0 12333.9 12393.7 12405.9 12546.7 12799.2 15320.5 15375.5 15493.6 15534.8 15650.8 5938.9 6030.6 6059.5 6074.2 6112.3 1091.9 1149.0 1156.7 1158.1 1199.1 29560.0 29587.3 29692.6 29925.1 30231.2 1120.1 1130.4 1146.1 1197.3 1227.9 15242.5 15343.5 15354.2 15624.4 15803.8 529108.0 536697.0 538351.0 539495.0 540409.0 57939.1 59082.0 59153.0 59203.4 59377.7 1508.7 1535.4 1539.6 1541.8 1544.1 31138.4 31694.7 31833.4 32014.0 32407.0 50985.7 51117.5 51152.5 51224.2 51631.0 319952.0 323604.0 323788.0 323880.0 323932.0 35355.8 35708.6 35954.6 36016.8 36025.8 46572.3 47071.5 47297.3 47374.8 47618.3 39625.4 39800.0 39821.6 39859.0 40902.8 38993.2 39021.0 39164.6 39286.6 39899.0 38605.8 38618.0 39632.6 39671.2 39706.6 34108.3 34373.8 34748.7 34761.5 34827.8 26775.9 27309.2 27427.6 27481.3 27528.9 06:09:57 INFO - 2016-01-25 06:09:57,280 DEBUG : BROWSER_OUTPUT: 06:09:57 INFO - 2016-01-25 06:09:57,280 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:33332.99 Median:2112.28 stddev:111740.17 (5290.0%) stddev-sans-first:112026.25 06:09:57 INFO - 2016-01-25 06:09:57,280 DEBUG : BROWSER_OUTPUT: Values: 389.2 392.2 392.3 394.1 396.6 16184.8 16640.2 17976.2 20394.5 20451.0 11489.9 12167.4 14069.4 17710.3 17841.6 4454.3 5117.7 5249.0 5737.2 5762.3 5664.9 5732.3 5753.6 5762.5 5766.9 5591.2 5660.5 5663.1 5666.4 5724.5 5603.3 5611.5 5615.1 5648.8 5651.2 5049.2 5069.0 5197.9 5209.9 5218.7 13051.7 13533.2 16693.2 19781.1 20364.8 2070.5 2080.9 2143.6 2193.6 2251.9 9903.1 9937.2 9951.6 9982.1 10113.9 1844.0 1867.7 1876.1 1913.8 2013.0 58561.4 58593.0 58910.0 62364.7 65982.7 10157.6 10724.1 10965.6 11038.6 11109.1 14136.4 14187.5 14419.4 14432.0 14434.2 8202.8 8224.3 8270.4 8492.5 8531.2 8040.8 8108.7 8138.8 8407.8 8624.8 4540.5 4550.4 4561.3 4641.6 4658.7 1896.4 1935.6 1950.9 1962.0 1966.5 881.7 951.1 964.3 974.1 1027.5 17161.8 17401.6 17627.6 17679.5 17749.6 982.2 1038.4 1060.1 1081.8 1092.3 9813.9 9828.8 9933.9 9952.7 10137.5 666391.0 669385.0 674944.0 699401.0 711509.0 74973.0 82280.0 84553.0 86370.6 88814.6 1191.8 1198.1 1210.5 1227.4 1240.2 16090.7 16104.3 16181.9 16235.5 16496.0 37025.4 37454.4 37525.8 37733.8 38767.0 50351.2 50657.7 51227.5 51412.0 53623.5 9625.4 9953.4 9977.3 10114.0 10118.5 11396.9 15293.3 15577.4 16780.9 17322.1 14265.4 14555.0 14590.9 14627.3 15294.8 14771.7 14877.8 14904.9 14929.9 14953.0 14515.2 14630.6 15621.6 15627.5 16091.8 10326.5 10402.9 10407.2 10415.8 10441.1 14612.4 14840.0 15063.5 15335.7 15399.3 06:09:57 INFO - 2016-01-25 06:09:57,280 DEBUG : BROWSER_OUTPUT: 06:09:57 INFO - 2016-01-25 06:09:57,280 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5755.89 Median:6055.42 stddev:3028.78 (50.0%) stddev-sans-first:3020.96 06:09:57 INFO - 2016-01-25 06:09:57,282 DEBUG : BROWSER_OUTPUT: Values: 1572.3 1589.8 1633.3 1835.3 1919.5 7086.8 7274.2 7916.7 8432.3 8439.5 7477.3 7755.4 7813.8 7821.8 7844.6 2324.5 2363.4 2364.7 2368.8 2370.7 2350.3 2371.4 2413.0 2425.1 2425.9 2334.8 2351.6 2392.0 2408.3 2417.2 2348.1 2362.9 2377.2 2380.8 2391.1 2352.6 2367.6 2386.8 2387.1 2407.7 8163.9 8260.6 8266.1 8295.5 8322.8 4889.6 4958.0 4962.0 4988.1 4992.3 3189.7 3190.8 3226.6 3265.4 3280.6 989.6 1003.3 1027.1 1035.0 1069.0 11465.5 11469.8 11470.2 11473.4 11498.9 4337.4 4429.9 4450.5 4515.3 4531.2 9737.0 9770.0 9794.4 9808.2 9813.9 4968.2 4985.9 4998.6 5001.4 5016.3 4381.4 4508.8 4525.4 4535.4 4539.9 3831.2 3831.5 3841.4 3843.4 3847.9 1155.7 1160.7 1166.7 1167.2 1174.7 1379.3 1385.7 1392.5 1396.3 1398.1 7750.6 7941.0 7957.3 7960.4 7963.3 439.9 442.9 472.3 477.6 478.2 6032.5 6078.3 6081.8 6083.0 6089.8 9595.6 10064.9 10090.2 10178.3 10226.5 9927.8 9967.8 9972.3 10016.1 10025.4 7416.5 7607.4 7608.9 7628.1 7635.7 7520.3 7536.3 7569.8 7572.0 7607.8 8458.5 8730.0 8791.8 8818.9 8824.9 8647.2 8834.9 8965.1 9091.4 9095.3 6989.5 7346.1 7406.3 7515.6 7532.6 8004.8 8019.1 8033.8 8041.4 8082.3 7359.3 7383.9 7479.3 7530.7 7556.7 7231.5 7347.8 7378.2 7424.5 7466.1 7575.0 7606.2 7622.4 7623.9 7638.7 6834.7 6866.3 6875.2 6894.4 6940.3 6928.2 6950.1 6986.2 7036.4 7046.6 06:09:57 INFO - 2016-01-25 06:09:57,282 DEBUG : BROWSER_OUTPUT: 06:09:57 INFO - 2016-01-25 06:09:57,282 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5629.60 Median:6438.76 stddev:1698.12 (26.4%) stddev-sans-first:1656.13 06:09:57 INFO - 2016-01-25 06:09:57,282 DEBUG : BROWSER_OUTPUT: Values: 357.1 359.0 360.9 360.9 361.8 6298.2 6361.0 6362.8 6369.7 6418.5 6180.4 6265.0 6344.9 6351.0 6360.6 4884.3 4898.7 4902.9 4904.0 4904.7 4896.3 4901.4 4904.8 4906.0 4907.0 4648.3 4811.9 4822.3 4832.5 4844.0 4760.4 4792.3 4795.5 4799.5 4800.8 4157.7 4160.9 4163.6 4170.9 4181.8 5883.7 5947.2 5954.2 5956.7 5968.4 5562.6 5574.5 5581.1 5585.8 5601.0 6633.3 6643.0 6645.8 6649.4 6664.2 4631.2 4632.4 4636.3 4638.3 4660.5 6762.0 6868.9 6959.5 6961.3 6968.9 4704.7 4721.1 4729.3 4747.4 4750.7 4808.0 4819.0 4830.6 4842.8 4849.3 5624.4 5625.9 5628.3 5636.3 5643.1 6653.0 6819.1 6829.7 6831.6 6835.5 1668.5 1704.3 1704.7 1706.4 1706.5 1109.9 1139.3 1141.1 1148.9 1154.5 6464.6 6481.9 6509.1 6524.2 6535.7 6997.8 6998.1 6999.3 6999.3 7001.7 6408.7 6459.1 6491.9 6502.7 6508.4 3770.7 3797.7 3800.0 3800.5 3805.2 7132.6 7132.7 7135.1 7146.2 7159.4 6987.3 7147.1 7153.1 7157.4 7180.7 7118.5 7143.1 7148.6 7163.2 7177.5 6944.8 6973.7 6976.8 6993.2 7008.4 6724.6 6858.0 6883.5 6901.7 6931.9 7123.4 7142.3 7153.5 7174.6 7178.3 4796.8 4798.4 4802.5 4811.8 4814.8 6879.8 6936.6 6984.9 7011.9 7013.2 6737.3 6747.8 6784.6 6790.0 6810.7 6725.9 6759.1 6776.6 6786.4 6791.3 6532.8 6639.6 6666.7 6679.6 6680.6 6741.8 6772.0 6804.0 6806.0 6809.9 6586.2 6616.5 6654.9 6658.3 6662.1 06:09:57 INFO - 2016-01-25 06:09:57,282 DEBUG : BROWSER_OUTPUT: 06:09:57 INFO - 2016-01-25 06:09:57,282 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14907.29 Median:27228.22 stddev:17391.70 (63.9%) stddev-sans-first:17408.06 06:09:57 INFO - 2016-01-25 06:09:57,282 DEBUG : BROWSER_OUTPUT: Values: 763.9 855.5 900.1 918.8 932.9 13529.5 13953.6 13980.5 14091.9 14156.6 13528.1 15024.1 15085.5 15207.5 15227.3 915.2 916.5 927.8 945.5 948.5 931.5 941.4 942.0 943.5 945.3 948.6 964.7 965.1 967.2 970.0 942.9 948.4 951.1 952.9 955.1 711.7 712.0 712.3 714.2 717.2 13379.5 13480.1 13484.8 13498.3 13518.4 12242.0 12680.6 12832.7 12953.4 13834.9 10435.8 10634.3 11386.4 11643.3 11766.6 3818.3 3856.9 3905.4 3928.4 3979.3 49900.5 49906.0 50104.0 50582.5 50629.7 10317.6 10372.5 10495.9 10536.3 10654.3 19693.5 19699.2 19782.7 20086.9 20096.8 8227.9 8291.1 8325.0 8366.4 8390.9 4394.8 4405.4 4625.2 4654.2 4696.4 3193.3 3209.1 3234.2 3238.3 3244.8 553.2 565.8 571.1 572.7 572.7 725.4 733.6 742.1 742.5 743.0 8488.9 8531.7 8567.8 8597.6 8598.8 693.4 698.8 726.2 742.8 745.4 4150.2 4224.7 4277.4 4301.5 4302.1 63600.7 63724.7 63741.7 64314.0 64739.7 54090.7 54600.7 55248.7 55571.0 55821.7 45162.8 45556.8 51783.7 52101.4 52137.0 9245.4 9252.4 9350.5 9561.4 9574.7 38154.8 38680.2 39034.0 39207.8 39652.6 49760.0 50153.7 50333.7 50682.5 50801.0 12408.8 12480.8 12569.2 12580.7 12867.2 13168.1 13332.4 13414.3 13480.4 13995.7 11853.0 12183.6 12703.7 12807.2 13117.2 11576.3 11587.9 11737.6 11801.4 11871.3 11896.8 11955.3 12147.6 12265.8 12483.9 9974.3 10053.5 10120.3 10129.9 10708.0 9662.6 9739.8 9786.7 9875.5 9905.1 06:09:57 INFO - 2016-01-25 06:09:57,282 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:09:57 INFO - 2016-01-25 06:09:57,283 DEBUG : BROWSER_OUTPUT: 06:09:57 INFO - 2016-01-25 06:09:57,900 INFO : Browser exited with error code: 0 06:09:57 INFO - 2016-01-25 06:09:57,919 INFO : Completed test dromaeo_css (00:18:28) 06:09:57 INFO - 2016-01-25 06:09:57,919 INFO : Starting test kraken 06:09:57 INFO - 2016-01-25 06:09:57,919 DEBUG : operating with platform_type : linux_ 06:09:57 INFO - 2016-01-25 06:09:57,919 INFO : Initialising browser for kraken test... 06:09:57 INFO - 2016-01-25 06:09:57,925 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpg4JqBg/profile http://localhost:51944/getInfo.html 06:10:01 INFO - 2016-01-25 06:10:01,139 DEBUG : BROWSER_OUTPUT: 06:10:01 INFO - 2016-01-25 06:10:01,140 DEBUG : BROWSER_OUTPUT: (process:22128): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:10:01 INFO - 2016-01-25 06:10:01,926 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:10:01 INFO - 2016-01-25 06:10:01,927 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:10:01 INFO - 2016-01-25 06:10:01,927 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:10:01 INFO - 2016-01-25 06:10:01,927 DEBUG : BROWSER_OUTPUT: __metrics 06:10:02 INFO - 2016-01-25 06:10:02,860 INFO : Browser initialized. 06:10:02 INFO - 2016-01-25 06:10:02,861 INFO : Running cycle 1/1 for kraken test... 06:10:02 INFO - 2016-01-25 06:10:02,861 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpg4JqBg/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:10:04 INFO - 2016-01-25 06:10:04,213 DEBUG : BROWSER_OUTPUT: 06:10:04 INFO - 2016-01-25 06:10:04,213 DEBUG : BROWSER_OUTPUT: (process:22242): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:10:14 INFO - 2016-01-25 06:10:14,712 DEBUG : BROWSER_OUTPUT: RSS: Main: 135753728 06:10:14 INFO - 2016-01-25 06:10:14,712 DEBUG : BROWSER_OUTPUT: 06:10:17 INFO - 2016-01-25 06:10:17,186 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51944/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51944/tests/kraken/driver.html?testName=audio-beat-detection) 06:10:17 INFO - 2016-01-25 06:10:17,780 DEBUG : BROWSER_OUTPUT: RSS: Main: 137093120 06:10:17 INFO - 2016-01-25 06:10:17,780 DEBUG : BROWSER_OUTPUT: 06:10:20 INFO - 2016-01-25 06:10:20,399 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51944/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51944/tests/kraken/driver.html?testName=audio-dft) 06:10:20 INFO - 2016-01-25 06:10:20,985 DEBUG : BROWSER_OUTPUT: RSS: Main: 139034624 06:10:20 INFO - 2016-01-25 06:10:20,985 DEBUG : BROWSER_OUTPUT: 06:10:23 INFO - 2016-01-25 06:10:23,805 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51944/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51944/tests/kraken/driver.html?testName=audio-fft) 06:10:24 INFO - 2016-01-25 06:10:24,374 DEBUG : BROWSER_OUTPUT: RSS: Main: 138203136 06:10:24 INFO - 2016-01-25 06:10:24,375 DEBUG : BROWSER_OUTPUT: 06:10:26 INFO - 2016-01-25 06:10:26,412 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51944/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51944/tests/kraken/driver.html?testName=audio-oscillator) 06:10:26 INFO - 2016-01-25 06:10:26,998 DEBUG : BROWSER_OUTPUT: RSS: Main: 137789440 06:10:26 INFO - 2016-01-25 06:10:26,998 DEBUG : BROWSER_OUTPUT: 06:10:29 INFO - 2016-01-25 06:10:29,190 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51944/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51944/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:10:29 INFO - 2016-01-25 06:10:29,772 DEBUG : BROWSER_OUTPUT: RSS: Main: 138932224 06:10:29 INFO - 2016-01-25 06:10:29,772 DEBUG : BROWSER_OUTPUT: 06:10:32 INFO - 2016-01-25 06:10:32,712 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51944/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51944/tests/kraken/driver.html?testName=imaging-darkroom) 06:10:33 INFO - 2016-01-25 06:10:33,293 DEBUG : BROWSER_OUTPUT: RSS: Main: 139038720 06:10:33 INFO - 2016-01-25 06:10:33,293 DEBUG : BROWSER_OUTPUT: 06:10:36 INFO - 2016-01-25 06:10:36,680 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51944/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51944/tests/kraken/driver.html?testName=imaging-desaturate) 06:10:37 INFO - 2016-01-25 06:10:37,281 DEBUG : BROWSER_OUTPUT: RSS: Main: 139485184 06:10:37 INFO - 2016-01-25 06:10:37,281 DEBUG : BROWSER_OUTPUT: 06:10:40 INFO - 2016-01-25 06:10:40,100 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51944/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51944/tests/kraken/driver.html?testName=json-parse-financial) 06:10:40 INFO - 2016-01-25 06:10:40,686 DEBUG : BROWSER_OUTPUT: RSS: Main: 137363456 06:10:40 INFO - 2016-01-25 06:10:40,687 DEBUG : BROWSER_OUTPUT: 06:10:42 INFO - 2016-01-25 06:10:42,260 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51944/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51944/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:10:42 INFO - 2016-01-25 06:10:42,842 DEBUG : BROWSER_OUTPUT: RSS: Main: 138817536 06:10:42 INFO - 2016-01-25 06:10:42,842 DEBUG : BROWSER_OUTPUT: 06:10:44 INFO - 2016-01-25 06:10:44,613 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51944/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51944/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:10:45 INFO - 2016-01-25 06:10:45,227 DEBUG : BROWSER_OUTPUT: RSS: Main: 138416128 06:10:45 INFO - 2016-01-25 06:10:45,228 DEBUG : BROWSER_OUTPUT: 06:10:47 INFO - 2016-01-25 06:10:47,265 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51944/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51944/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:10:47 INFO - 2016-01-25 06:10:47,851 DEBUG : BROWSER_OUTPUT: RSS: Main: 138764288 06:10:47 INFO - 2016-01-25 06:10:47,851 DEBUG : BROWSER_OUTPUT: 06:10:50 INFO - 2016-01-25 06:10:50,266 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51944/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51944/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:10:50 INFO - 2016-01-25 06:10:50,857 DEBUG : BROWSER_OUTPUT: RSS: Main: 138416128 06:10:50 INFO - 2016-01-25 06:10:50,857 DEBUG : BROWSER_OUTPUT: 06:10:53 INFO - 2016-01-25 06:10:53,392 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51944/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51944/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:10:53 INFO - 2016-01-25 06:10:53,974 DEBUG : BROWSER_OUTPUT: RSS: Main: 139632640 06:10:53 INFO - 2016-01-25 06:10:53,974 DEBUG : BROWSER_OUTPUT: 06:10:55 INFO - 2016-01-25 06:10:55,623 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51944/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51944/tests/kraken/driver.html?testName=ai-astar) 06:10:55 INFO - 2016-01-25 06:10:55,881 DEBUG : BROWSER_OUTPUT: RSS: Main: 139063296 06:10:55 INFO - 2016-01-25 06:10:55,882 DEBUG : BROWSER_OUTPUT: 06:10:55 INFO - 2016-01-25 06:10:55,882 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:10:55 INFO - 2016-01-25 06:10:55,882 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:10:55 INFO - 2016-01-25 06:10:55,882 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:10:55 INFO - 2016-01-25 06:10:55,883 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:10:55 INFO - 2016-01-25 06:10:55,883 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;105;111;111;112;122;110;110;110;111 06:10:55 INFO - 2016-01-25 06:10:55,883 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;133;151;156;125;151;164;124;162;122 06:10:55 INFO - 2016-01-25 06:10:55,883 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;162;161;162;161;163;163;162;166 06:10:55 INFO - 2016-01-25 06:10:55,883 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;75;174;74;71;70;72;163;73 06:10:55 INFO - 2016-01-25 06:10:55,884 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;140;92;93;93;136;91;94;134 06:10:55 INFO - 2016-01-25 06:10:55,884 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;110;110;109;110;110;110;110 06:10:55 INFO - 2016-01-25 06:10:55,884 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;150;146;146;147;146;147;146;147;149;145 06:10:55 INFO - 2016-01-25 06:10:55,884 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;97;95;96;97;96;98;96;96;95 06:10:55 INFO - 2016-01-25 06:10:55,884 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;58;60;62;58;58;59;60;65;57 06:10:55 INFO - 2016-01-25 06:10:55,885 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;65;67;64;66;65;65;64;65;65 06:10:55 INFO - 2016-01-25 06:10:55,885 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;82;82;90;87;83;89;83;82;83 06:10:55 INFO - 2016-01-25 06:10:55,885 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;119;126;121;116;114;119;116;115;123 06:10:55 INFO - 2016-01-25 06:10:55,885 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;149;145;144;137;144;146;145;145;144;145 06:10:55 INFO - 2016-01-25 06:10:55,885 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;65;65;65;69;65;65;65;65;70 06:10:55 INFO - 2016-01-25 06:10:55,885 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:10:55 INFO - 2016-01-25 06:10:55,885 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:10:55 INFO - 2016-01-25 06:10:55,885 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,693 06:10:55 INFO - 2016-01-25 06:10:55,886 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:10:55 INFO - 2016-01-25 06:10:55,886 DEBUG : BROWSER_OUTPUT: __startTimestamp1453731055876__endTimestamp 06:10:55 INFO - 2016-01-25 06:10:55,886 DEBUG : BROWSER_OUTPUT: 06:10:55 INFO - 2016-01-25 06:10:55,886 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:10:55 INFO - 2016-01-25 06:10:55,886 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:10:55 INFO - 2016-01-25 06:10:55,886 DEBUG : BROWSER_OUTPUT: 06:10:55 INFO - 2016-01-25 06:10:55,886 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.30 Median:111.00 stddev:4.22 (3.8%) stddev-sans-first:4.47 06:10:55 INFO - 2016-01-25 06:10:55,887 DEBUG : BROWSER_OUTPUT: Values: 111.0 105.0 111.0 111.0 112.0 122.0 110.0 110.0 110.0 111.0 06:10:55 INFO - 2016-01-25 06:10:55,887 DEBUG : BROWSER_OUTPUT: 06:10:55 INFO - 2016-01-25 06:10:55,887 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.00 Median:151.50 stddev:16.32 (10.8%) stddev-sans-first:17.05 06:10:55 INFO - 2016-01-25 06:10:55,887 DEBUG : BROWSER_OUTPUT: Values: 152.0 133.0 151.0 156.0 125.0 151.0 164.0 124.0 162.0 122.0 06:10:55 INFO - 2016-01-25 06:10:55,887 DEBUG : BROWSER_OUTPUT: 06:10:55 INFO - 2016-01-25 06:10:55,888 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.40 Median:162.00 stddev:1.43 (0.9%) stddev-sans-first:1.51 06:10:55 INFO - 2016-01-25 06:10:55,888 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 162.0 161.0 162.0 161.0 163.0 163.0 162.0 166.0 06:10:55 INFO - 2016-01-25 06:10:55,888 DEBUG : BROWSER_OUTPUT: 06:10:55 INFO - 2016-01-25 06:10:55,888 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:91.70 Median:72.50 stddev:40.58 (56.0%) stddev-sans-first:42.48 06:10:55 INFO - 2016-01-25 06:10:55,888 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 75.0 174.0 74.0 71.0 70.0 72.0 163.0 73.0 06:10:55 INFO - 2016-01-25 06:10:55,888 DEBUG : BROWSER_OUTPUT: 06:10:55 INFO - 2016-01-25 06:10:55,888 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.90 Median:93.00 stddev:21.29 (22.9%) stddev-sans-first:22.07 06:10:55 INFO - 2016-01-25 06:10:55,890 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 140.0 92.0 93.0 93.0 136.0 91.0 94.0 134.0 06:10:55 INFO - 2016-01-25 06:10:55,890 DEBUG : BROWSER_OUTPUT: 06:10:55 INFO - 2016-01-25 06:10:55,890 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 06:10:55 INFO - 2016-01-25 06:10:55,890 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 110.0 110.0 109.0 110.0 110.0 110.0 110.0 06:10:55 INFO - 2016-01-25 06:10:55,890 DEBUG : BROWSER_OUTPUT: 06:10:55 INFO - 2016-01-25 06:10:55,890 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:1.52 (1.0%) stddev-sans-first:1.13 06:10:55 INFO - 2016-01-25 06:10:55,890 DEBUG : BROWSER_OUTPUT: Values: 150.0 146.0 146.0 147.0 146.0 147.0 146.0 147.0 149.0 145.0 06:10:55 INFO - 2016-01-25 06:10:55,890 DEBUG : BROWSER_OUTPUT: 06:10:55 INFO - 2016-01-25 06:10:55,891 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.50 stddev:0.95 (1.0%) stddev-sans-first:0.97 06:10:55 INFO - 2016-01-25 06:10:55,891 DEBUG : BROWSER_OUTPUT: Values: 97.0 97.0 95.0 96.0 97.0 96.0 98.0 96.0 96.0 95.0 06:10:55 INFO - 2016-01-25 06:10:55,891 DEBUG : BROWSER_OUTPUT: 06:10:55 INFO - 2016-01-25 06:10:55,891 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.50 Median:59.50 stddev:2.42 (4.1%) stddev-sans-first:2.50 06:10:55 INFO - 2016-01-25 06:10:55,891 DEBUG : BROWSER_OUTPUT: Values: 58.0 58.0 60.0 62.0 58.0 58.0 59.0 60.0 65.0 57.0 06:10:55 INFO - 2016-01-25 06:10:55,891 DEBUG : BROWSER_OUTPUT: 06:10:55 INFO - 2016-01-25 06:10:55,891 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.94 (1.5%) stddev-sans-first:0.93 06:10:55 INFO - 2016-01-25 06:10:55,891 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 67.0 64.0 66.0 65.0 65.0 64.0 65.0 65.0 06:10:55 INFO - 2016-01-25 06:10:55,891 DEBUG : BROWSER_OUTPUT: 06:10:55 INFO - 2016-01-25 06:10:55,892 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:83.00 stddev:3.22 (3.9%) stddev-sans-first:3.21 06:10:55 INFO - 2016-01-25 06:10:55,892 DEBUG : BROWSER_OUTPUT: Values: 81.0 82.0 82.0 90.0 87.0 83.0 89.0 83.0 82.0 83.0 06:10:55 INFO - 2016-01-25 06:10:55,892 DEBUG : BROWSER_OUTPUT: 06:10:55 INFO - 2016-01-25 06:10:55,892 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.90 Median:119.50 stddev:3.78 (3.2%) stddev-sans-first:3.99 06:10:55 INFO - 2016-01-25 06:10:55,892 DEBUG : BROWSER_OUTPUT: Values: 120.0 119.0 126.0 121.0 116.0 114.0 119.0 116.0 115.0 123.0 06:10:55 INFO - 2016-01-25 06:10:55,892 DEBUG : BROWSER_OUTPUT: 06:10:55 INFO - 2016-01-25 06:10:55,892 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.40 Median:145.00 stddev:2.99 (2.1%) stddev-sans-first:2.67 06:10:55 INFO - 2016-01-25 06:10:55,892 DEBUG : BROWSER_OUTPUT: Values: 149.0 145.0 144.0 137.0 144.0 146.0 145.0 145.0 144.0 145.0 06:10:55 INFO - 2016-01-25 06:10:55,892 DEBUG : BROWSER_OUTPUT: 06:10:55 INFO - 2016-01-25 06:10:55,893 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:65.00 stddev:1.89 (2.9%) stddev-sans-first:2.00 06:10:55 INFO - 2016-01-25 06:10:55,893 DEBUG : BROWSER_OUTPUT: Values: 66.0 65.0 65.0 65.0 69.0 65.0 65.0 65.0 65.0 70.0 06:10:55 INFO - 2016-01-25 06:10:55,893 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:10:55 INFO - 2016-01-25 06:10:55,893 DEBUG : BROWSER_OUTPUT: 06:10:56 INFO - 2016-01-25 06:10:56,628 INFO : Browser exited with error code: 0 06:10:56 INFO - 2016-01-25 06:10:56,679 INFO : Completed test kraken (00:00:58) 06:10:56 INFO - 2016-01-25 06:10:56,679 INFO : Starting test v8_7 06:10:56 INFO - 2016-01-25 06:10:56,679 DEBUG : operating with platform_type : linux_ 06:10:56 INFO - 2016-01-25 06:10:56,679 INFO : Initialising browser for v8_7 test... 06:10:56 INFO - 2016-01-25 06:10:56,685 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSvT90C/profile http://localhost:51944/getInfo.html 06:10:59 INFO - 2016-01-25 06:10:59,906 DEBUG : BROWSER_OUTPUT: 06:10:59 INFO - 2016-01-25 06:10:59,906 DEBUG : BROWSER_OUTPUT: (process:22551): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:11:00 INFO - 2016-01-25 06:11:00,713 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:11:00 INFO - 2016-01-25 06:11:00,714 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:11:00 INFO - 2016-01-25 06:11:00,714 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:11:00 INFO - 2016-01-25 06:11:00,714 DEBUG : BROWSER_OUTPUT: __metrics 06:11:01 INFO - 2016-01-25 06:11:01,604 INFO : Browser initialized. 06:11:01 INFO - 2016-01-25 06:11:01,605 INFO : Running cycle 1/1 for v8_7 test... 06:11:01 INFO - 2016-01-25 06:11:01,605 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSvT90C/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:11:02 INFO - 2016-01-25 06:11:02,942 DEBUG : BROWSER_OUTPUT: 06:11:02 INFO - 2016-01-25 06:11:02,942 DEBUG : BROWSER_OUTPUT: (process:22666): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:11:13 INFO - 2016-01-25 06:11:13,450 DEBUG : BROWSER_OUTPUT: RSS: Main: 135839744 06:11:13 INFO - 2016-01-25 06:11:13,450 DEBUG : BROWSER_OUTPUT: 06:11:34 INFO - 2016-01-25 06:11:34,785 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51944/tests/v8_7/run.html (next: http://localhost:51944/tests/v8_7/run.html) 06:11:35 INFO - 2016-01-25 06:11:35,036 DEBUG : BROWSER_OUTPUT: RSS: Main: 135974912 06:11:35 INFO - 2016-01-25 06:11:35,036 DEBUG : BROWSER_OUTPUT: 06:11:35 INFO - 2016-01-25 06:11:35,036 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:11:35 INFO - 2016-01-25 06:11:35,036 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:11:35 INFO - 2016-01-25 06:11:35,037 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:11:35 INFO - 2016-01-25 06:11:35,037 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:11:35 INFO - 2016-01-25 06:11:35,037 DEBUG : BROWSER_OUTPUT: |0;Richards;167.0564650851988 06:11:35 INFO - 2016-01-25 06:11:35,037 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;167.7008217340265 06:11:35 INFO - 2016-01-25 06:11:35,037 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.6420581655481 06:11:35 INFO - 2016-01-25 06:11:35,037 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5202.072538860104 06:11:35 INFO - 2016-01-25 06:11:35,038 DEBUG : BROWSER_OUTPUT: |4;RayTrace;892.8571428571429 06:11:35 INFO - 2016-01-25 06:11:35,038 DEBUG : BROWSER_OUTPUT: |5;Earley;552.4861878453039 06:11:35 INFO - 2016-01-25 06:11:35,038 DEBUG : BROWSER_OUTPUT: |6;Boyer;11517.241379310344 06:11:35 INFO - 2016-01-25 06:11:35,038 DEBUG : BROWSER_OUTPUT: |7;RegExp;23857.14285714286 06:11:35 INFO - 2016-01-25 06:11:35,038 DEBUG : BROWSER_OUTPUT: |8;Splay;532.197977647685 06:11:35 INFO - 2016-01-25 06:11:35,039 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 06:11:35 INFO - 2016-01-25 06:11:35,039 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:11:35 INFO - 2016-01-25 06:11:35,039 DEBUG : BROWSER_OUTPUT: __startTimestamp1453731095034__endTimestamp 06:11:35 INFO - 2016-01-25 06:11:35,039 DEBUG : BROWSER_OUTPUT: 06:11:35 INFO - 2016-01-25 06:11:35,039 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:11:35 INFO - 2016-01-25 06:11:35,040 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:11:35 INFO - 2016-01-25 06:11:35,040 DEBUG : BROWSER_OUTPUT: 06:11:35 INFO - 2016-01-25 06:11:35,040 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.06 Median:167.06 stddev:0.00 (0.0%) 06:11:35 INFO - 2016-01-25 06:11:35,040 DEBUG : BROWSER_OUTPUT: Values: 167.1 06:11:35 INFO - 2016-01-25 06:11:35,040 DEBUG : BROWSER_OUTPUT: 06:11:35 INFO - 2016-01-25 06:11:35,040 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:167.70 Median:167.70 stddev:0.00 (0.0%) 06:11:35 INFO - 2016-01-25 06:11:35,040 DEBUG : BROWSER_OUTPUT: Values: 167.7 06:11:35 INFO - 2016-01-25 06:11:35,041 DEBUG : BROWSER_OUTPUT: 06:11:35 INFO - 2016-01-25 06:11:35,041 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.64 Median:279.64 stddev:0.00 (0.0%) 06:11:35 INFO - 2016-01-25 06:11:35,041 DEBUG : BROWSER_OUTPUT: Values: 279.6 06:11:35 INFO - 2016-01-25 06:11:35,041 DEBUG : BROWSER_OUTPUT: 06:11:35 INFO - 2016-01-25 06:11:35,041 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 06:11:35 INFO - 2016-01-25 06:11:35,041 DEBUG : BROWSER_OUTPUT: Values: 5202.1 06:11:35 INFO - 2016-01-25 06:11:35,041 DEBUG : BROWSER_OUTPUT: 06:11:35 INFO - 2016-01-25 06:11:35,041 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:892.86 Median:892.86 stddev:0.00 (0.0%) 06:11:35 INFO - 2016-01-25 06:11:35,041 DEBUG : BROWSER_OUTPUT: Values: 892.9 06:11:35 INFO - 2016-01-25 06:11:35,041 DEBUG : BROWSER_OUTPUT: 06:11:35 INFO - 2016-01-25 06:11:35,041 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:552.49 Median:552.49 stddev:0.00 (0.0%) 06:11:35 INFO - 2016-01-25 06:11:35,041 DEBUG : BROWSER_OUTPUT: Values: 552.5 06:11:35 INFO - 2016-01-25 06:11:35,042 DEBUG : BROWSER_OUTPUT: 06:11:35 INFO - 2016-01-25 06:11:35,042 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11517.24 Median:11517.24 stddev:0.00 (0.0%) 06:11:35 INFO - 2016-01-25 06:11:35,042 DEBUG : BROWSER_OUTPUT: Values: 11517.2 06:11:35 INFO - 2016-01-25 06:11:35,042 DEBUG : BROWSER_OUTPUT: 06:11:35 INFO - 2016-01-25 06:11:35,042 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23857.14 Median:23857.14 stddev:0.00 (0.0%) 06:11:35 INFO - 2016-01-25 06:11:35,042 DEBUG : BROWSER_OUTPUT: Values: 23857.1 06:11:35 INFO - 2016-01-25 06:11:35,042 DEBUG : BROWSER_OUTPUT: 06:11:35 INFO - 2016-01-25 06:11:35,042 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:532.20 Median:532.20 stddev:0.00 (0.0%) 06:11:35 INFO - 2016-01-25 06:11:35,042 DEBUG : BROWSER_OUTPUT: Values: 532.2 06:11:35 INFO - 2016-01-25 06:11:35,042 DEBUG : BROWSER_OUTPUT: 06:11:35 INFO - 2016-01-25 06:11:35,042 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 06:11:35 INFO - 2016-01-25 06:11:35,042 DEBUG : BROWSER_OUTPUT: Values: 4835.7 06:11:35 INFO - 2016-01-25 06:11:35,044 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:11:35 INFO - 2016-01-25 06:11:35,044 DEBUG : BROWSER_OUTPUT: 06:11:35 INFO - 2016-01-25 06:11:35,856 INFO : Browser exited with error code: 0 06:11:35 INFO - 2016-01-25 06:11:35,871 INFO : Completed test v8_7 (00:00:39) 06:11:36 INFO - 2016-01-25 06:11:36,097 INFO : Completed test suite (00:20:06) 06:11:36 INFO - 2016-01-25 06:11:36,098 DEBUG : Working with test: dromaeo_css 06:11:36 INFO - 2016-01-25 06:11:36,098 DEBUG : Generating results file: dromaeo_css 06:11:36 INFO - 2016-01-25 06:11:36,099 DEBUG : Working with test: kraken 06:11:36 INFO - 2016-01-25 06:11:36,099 DEBUG : Generating results file: kraken 06:11:36 INFO - 2016-01-25 06:11:36,099 INFO : javascript benchmark 06:11:36 INFO - 2016-01-25 06:11:36,099 DEBUG : Working with test: v8_7 06:11:36 INFO - 2016-01-25 06:11:36,100 DEBUG : Generating results file: v8_7 06:11:36 INFO - 2016-01-25 06:11:36,100 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:11:36 INFO - 2016-01-25 06:11:36,153 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 06:11:36 INFO - 2016-01-25 06:11:36,154 DEBUG : process_Request line: dromaeo_css 7386.03 graph.html#tests=[[72,52,43]] 06:11:36 INFO - 2016-01-25 06:11:36,154 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:11:36 INFO - 2016-01-25 06:11:36,187 DEBUG : process_Request line: kraken 1506.30 graph.html#tests=[[232,52,43]] 06:11:36 INFO - 2016-01-25 06:11:36,187 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:11:36 INFO - 2016-01-25 06:11:36,217 DEBUG : process_Request line: v8_7 23129.10 graph.html#tests=[[230,52,43]] 06:11:36 INFO - 2016-01-25 06:11:36,218 INFO : javascript benchmark 06:11:36 INFO - 2016-01-25 06:11:36,222 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3331.3836940166066, 3438.106092415971, 3457.1011537000372, 3472.357613841438, 3481.2863363010583, 5472.945270547293, 5579.38626751057, 5596.4123767004485, 5611.158326251059, 5612.635178713386, 5599.524040456566, 5710.7430165642545, 5724.62789918656, 5753.856153596152, 5754.453326933945, 5168.043911876315, 5218.869528261805, 5246.5802735781235, 5273.841784746463, 5277.050130976423, 5072.923906141411, 5087.364079490064, 5187.610929180308, 5206.869828254286, 5209.7134657593815, 5120.15517439622, 5216.478352164772, 5232.895342093156, 5236.083685355066, 5250.868728281805, 5210.76551555181, 5286.7885284588765, 5297.682139071668, 5301.363836339664, 5328.333958255218, 4977.0, 5032.572231360339, 5042.470540593258, 5136.126858434075, 5174.456682048406, 5451.754671039813, 5481.588880833913, 5495.477929596682, 5530.972345138249, 5563.471470210324, 6190.473809726133, 6194.473469755077, 6194.783182588588, 6207.534434917354, 6215.06773983906, 5884.470397664188, 6000.429959153874, 6006.579539432241, 6009.669468179249, 6245.063240513914, 5661.2357331760095, 5717.514011309002, 5746.367899531048, 5755.338136114358, 5782.595218334718, 6201.534884883652, 6257.843553911189, 6257.874842503215, 6262.091996660459, 6273.466755325757, 5947.256592925884, 5986.4013598639785, 6018.398160184034, 6066.120412540157, 6080.391960803884, 6105.603135796159, 6142.447179753844, 6150.292716337678, 6205.069239614094, 6224.502039836802, 6109.663968481687, 6135.9079613805825, 6164.075388691732, 6168.722407491674, 6189.876202475925, 5739.024365857731, 5849.7952571660635, 5959.344472108065, 6070.3929607038945, 6089.512838972872, 4668.533146685304, 4699.389079419653, 4709.175894218498, 4710.764461776897, 4731.858044258678, 4227.112306415687, 4229.555896630809, 4232.576742325743, 4235.555266697014, 4249.553796851348, 5660.066089095253, 5711.485966263056, 5780.306363236438, 5821.446962538552, 5825.2135961644635, 6206.565540412218, 6247.187865577446, 6266.342034086447, 6276.529260305495, 6312.368763123651, 5604.8318550443555, 5878.735456904449, 5896.823095307148, 5902.3507414184405, 5905.291365036223, 5028.949710502849, 5132.948670513247, 5145.871353216199, 5156.716380599103, 5173.689578625294, 6313.810585682437, 6318.273398559132, 6318.431341179224, 6321.96839015802, 6353.904691429632, 5832.825015249549, 5941.643501389931, 6226.439620434183, 6229.56393052482, 6244.313125556095, 6174.073888916699, 6332.0, 6336.651484168415, 6343.080253363144, 6346.238451385863, 6052.364501727431, 6065.4541091302, 6102.4812890902995, 6134.171886795226, 6134.35589263121, 5939.316978547522, 5982.102684597346, 6110.480609148272, 6156.476699480415, 6226.470749986302, 5983.491403230774, 6008.339082700812, 6012.338642749207, 6013.789517366871, 6037.486813620892, 5943.64338139713, 5981.820545383645, 5984.072468767348, 5994.550408719277, 6002.159697642246, 5655.575831812548, 5729.942700572941, 5753.3958934311295, 5908.615939963888, 5917.0, 6007.789727359522, 6097.451229389376, 6103.511719062376, 6135.785247516315, 6136.8772624548155, 5892.734826932884, 5975.312839023568, 5986.0, 5987.371326010706, 6000.69996500182], "unit": "ms", "name": "dojo.html", "value": 5636.24781761084}, {"lowerIsBetter": false, "replicates": [598.9011813050844, 641.0576452614656, 648.575183254968, 662.5693299355421, 676.489250615785, 32815.50776738351, 41789.373159402596, 41829.0, 41903.37144942828, 42000.369994450106, 45931.311030334575, 46413.0, 46545.53454465454, 46571.534284657144, 46575.534244657545, 9002.954985225064, 9069.773255668595, 9084.954575227115, 9141.634334626608, 9160.35877488576, 8924.062973387798, 9034.232090272302, 9043.638254469814, 9049.909500904972, 9058.773530661752, 9013.684521041765, 9035.277177825757, 9098.408603440788, 9110.681126160585, 9142.040085790995, 8959.865602015974, 8983.685571004984, 9059.048799876049, 9060.728178154633, 9063.320250981169, 8923.776905577348, 9057.592408341641, 9072.637094516278, 9082.954585227031, 9098.0, 40728.0, 41130.79434602808, 41143.0, 41225.0, 41314.586854131376, 3544.769589976643, 3566.3937130687846, 3572.464130380438, 3610.6930910872607, 3625.075605720551, 31148.844255778804, 31672.841635791905, 31852.522212166838, 32175.0, 32581.674183258103, 4136.607022332873, 4151.12826306476, 4171.478565179353, 4172.332426811696, 4244.469441319835, 272179.0, 273595.8960615592, 273791.0, 273944.0, 274088.0, 45522.317165242544, 45622.31566526505, 45970.0, 46038.0, 46050.30924536135, 43485.0, 43535.56464435315, 43566.0, 43575.0, 43637.78181109074, 15971.760423593656, 16056.0, 16066.75899861503, 16113.194340282938, 16136.031838089517, 12333.876661233453, 12393.690157746129, 12405.875941240472, 12546.68633284157, 12799.232046077264, 15320.463783767515, 15375.538733838002, 15493.612659683373, 15534.766978495332, 15650.843491564938, 5938.940610593925, 6030.577859549877, 6059.515238780887, 6074.179985701962, 6112.327643959161, 1091.8853520380405, 1148.9716703550444, 1156.7455159864817, 1158.0735411670798, 1199.1306302930307, 29560.0, 29587.26031849178, 29692.554611680844, 29925.10224693219, 30231.244218894702, 1120.0871289898707, 1130.37829193943, 1146.146096220422, 1197.3354788092518, 1227.877212278765, 15242.542723718307, 15343.53969380898, 15354.232288385536, 15624.375024998873, 15803.762943555856, 529108.0, 536697.0, 538351.0, 539495.0, 540409.0, 57939.13091303634, 59082.0, 59153.0, 59203.407965920655, 59377.70311148417, 1508.6907184027248, 1535.4165417141414, 1539.6150962259435, 1541.8381069987713, 1544.0658401667279, 31138.377232455678, 31694.683053170094, 31833.36333273275, 32014.0, 32407.0, 50985.7450712744, 51117.48882511276, 51152.48847511477, 51224.23163652474, 51631.0, 319952.0, 323604.0, 323788.0, 323880.0, 323932.0, 35355.82322088373, 35708.64291357053, 35954.64045359513, 36016.819915900254, 36025.81987090048, 46572.30141547947, 47071.52928470672, 47297.29054064123, 47374.763126184145, 47618.285725714835, 39625.40561891516, 39800.0, 39821.60178398179, 39859.0, 40902.795486022376, 38993.22013559656, 39021.0, 39164.6083539161, 39286.607133929436, 39899.0, 38605.806970964964, 38618.0, 39632.60367396405, 39671.2065758689, 39706.60293397029, 34108.31783364269, 34373.82813085918, 34748.65251347555, 34761.478577820846, 34827.82586087054, 26775.86612066927, 27309.180724577498, 27427.588586171623, 27481.31296717598, 27528.862355688092], "unit": "ms", "name": "ext.html", "value": 19398.5699639278}, {"lowerIsBetter": false, "replicates": [389.2215568862275, 392.1607759394894, 392.26646171658996, 394.1466724541368, 396.6331143692084, 16184.83815161848, 16640.167991600432, 17976.191071401787, 20394.490137746565, 20451.0, 11489.942550287236, 12167.391630418466, 14069.437222511113, 17710.291588336484, 17841.553961150978, 4454.265046267362, 5117.718525481087, 5248.976449592331, 5737.225474560943, 5762.308522977249, 5664.943350566504, 5732.283464566929, 5753.597248192628, 5762.4525670061275, 5766.913496297559, 5591.189277554772, 5660.518855897254, 5663.0655941769555, 5666.433356664342, 5724.513416359614, 5603.299587551556, 5611.494965453108, 5615.129654903476, 5648.774049038034, 5651.2370829938045, 5049.2173713074535, 5068.960863023109, 5197.896042079137, 5209.895802083975, 5218.739063046833, 13051.738965220737, 13533.188008719508, 16693.248803803857, 19781.109850056782, 20364.79635203644, 2070.5030792609814, 2080.937571872846, 2143.6248656485054, 2193.6270833958265, 2251.9190788421483, 9903.108720215216, 9937.205023598095, 9951.601935922554, 9982.051705088004, 10113.89886101137, 1843.9815601843943, 1867.6638205123072, 1876.1463534091956, 1913.7607799025122, 2012.9899350503301, 58561.41438585645, 58593.0, 58910.0, 62364.68817655928, 65982.67008664926, 10157.644482443078, 10724.088452481627, 10965.56137754481, 11038.558457661764, 11109.055730262857, 14136.444991050976, 14187.503437379848, 14419.35112919921, 14432.0, 14434.206118663364, 8202.753917382488, 8224.259816616533, 8270.37972152091, 8492.532910689848, 8531.23218910301, 8040.839183216303, 8108.716194933149, 8138.755837324889, 8407.831843363221, 8624.827503449897, 4540.523245059221, 4550.408446901948, 4561.29299958507, 4641.582257596832, 4658.67389282747, 1896.3741965151467, 1935.6128774245208, 1950.882947023183, 1962.0189905047475, 1966.5083729067733, 881.7442941547008, 951.0632027452954, 964.2719746591279, 974.1184228273424, 1027.4913917610832, 17161.828381716274, 17401.56496087608, 17627.55931101707, 17679.469615911545, 17749.645007099785, 982.1700662939804, 1038.3769738157196, 1060.1359891688248, 1081.8214994525972, 1092.3282181458505, 9813.852792208123, 9828.754281143028, 9933.850992235122, 9952.651657191964, 10137.543810528545, 666391.0, 669385.0, 674944.0, 699401.0, 711509.0, 74973.0, 82280.0, 84553.0, 86370.56814716011, 88814.55592721995, 1191.7795207886568, 1198.083466148397, 1210.4915935307192, 1227.429245400875, 1240.1814802230485, 16090.678186435971, 16104.275307610951, 16181.919090404472, 16235.512934611981, 16496.0, 37025.444618330206, 37454.43818342782, 37525.81237093797, 37733.81133094427, 38767.03082422962, 50351.24473132979, 50657.74671126768, 51227.48772512227, 51412.0, 53623.463765363405, 9625.422474651543, 9953.353032052893, 9977.251706121924, 10114.0, 10118.494075296352, 11396.886031139582, 15293.31180096876, 15577.37690492413, 16780.916095419932, 17322.133893305538, 14265.42938282457, 14555.0, 14590.927045364706, 14627.268636568342, 15294.847051529343, 14771.704565908836, 14877.776833347725, 14904.850951490347, 14929.925350373178, 14953.0, 14515.201663908587, 14630.634234144232, 15621.609459763597, 15627.453039143575, 16091.839081609034, 10326.48367581633, 10402.895971040192, 10407.21945854079, 10415.843762343722, 10441.112505436819, 14612.415503379745, 14840.0, 15063.54809355721, 15335.693286134438, 15399.3070311834], "unit": "ms", "name": "jquery.html", "value": 9260.782593524027}, {"lowerIsBetter": false, "replicates": [1572.316042521503, 1589.785378973838, 1633.3221712989114, 1835.3392778599703, 1919.5009297582633, 7086.822829429267, 7274.236205198457, 7916.722914697987, 8432.283255923247, 8439.451435656685, 7477.2896574825445, 7755.37956963443, 7813.843723125548, 7821.804454888631, 7844.568548729818, 2324.523472688099, 2363.3500787283465, 2364.6689463475127, 2368.786809187173, 2370.668106465096, 2350.2714158610884, 2371.3597328721235, 2412.95174096518, 2425.126954296452, 2425.866577338246, 2334.7781960713705, 2351.5649604823075, 2392.0431827269144, 2408.301592538162, 2417.2144053182697, 2348.072511358004, 2362.917297894574, 2377.156109581091, 2380.821438392119, 2391.1033362489065, 2352.6235802271553, 2367.5856725073218, 2386.809055275574, 2387.0571124405938, 2407.65089062085, 8163.918360816375, 8260.628271727786, 8266.090730019692, 8295.460795048302, 8322.791930201733, 4889.633277504201, 4957.975210123962, 4962.0, 4988.102141614508, 4992.301077849104, 3189.681031896792, 3190.808551486918, 3226.6450690424035, 3265.4122257993554, 3280.6063272407464, 989.5744829723216, 1003.2826529031777, 1027.085893554737, 1035.0425856083168, 1069.0165048155716, 11465.484053217542, 11469.827952580801, 11470.197086203969, 11473.426328683616, 11498.942505287503, 4337.436133302651, 4429.867103986886, 4450.532694067077, 4515.322701594787, 4531.207038768268, 9737.0, 9769.951150244204, 9794.363366381162, 9808.21534277256, 9813.901860981441, 4968.180250258739, 4985.853253751585, 4998.600111991032, 5001.399832020181, 5016.297718319438, 4381.364702118175, 4508.81964721414, 4525.434320709911, 4535.387722657465, 4539.931901021488, 3831.233753249361, 3831.482749828793, 3841.4237864320576, 3843.385058390644, 3847.8653247136217, 1155.6706338693432, 1160.6808127764932, 1166.722438929371, 1167.1654766841748, 1174.7004513848915, 1379.2620947792882, 1385.7020740540831, 1392.4987004678308, 1396.3297617143626, 1398.1261711430357, 7750.573718445539, 7940.960295198487, 7957.323627491613, 7960.363170946311, 7963.323117534958, 439.8900274931267, 442.8671398580413, 472.3175012107472, 477.5630298277107, 478.239599037532, 6032.547558933097, 6078.300995385499, 6081.8479538011015, 6083.0, 6089.756409743561, 9595.616175353047, 10064.949675251723, 10090.192784577217, 10178.287519873538, 10226.488675566341, 9927.751806204902, 9967.80064398708, 9972.252081093948, 10016.14862736661, 10025.448600327052, 7416.517926334771, 7607.391408687292, 7608.885866712004, 7628.084629844343, 7635.656395462218, 7520.323170914644, 7536.284053014955, 7569.772906812805, 7572.0, 7607.847843043219, 8458.450200736932, 8729.956350218208, 8791.824163516821, 8818.867716984121, 8824.867626985471, 8647.178518040777, 8834.911650883409, 8965.148310910454, 9091.409058411447, 9095.317851161057, 6989.545679530815, 7346.11846578414, 7406.333429991327, 7515.624218788929, 7532.585707786125, 8004.83990320202, 8019.077806052379, 8033.799155021171, 8041.437099402986, 8082.313003394777, 7359.264073592598, 7383.889241661272, 7479.289467500579, 7530.698772049057, 7556.697732090654, 7231.5299505531975, 7347.8163045924275, 7378.188399275968, 7424.480286379901, 7466.066741657293, 7574.962125189339, 7606.163322034461, 7622.390208783395, 7623.923760762322, 7638.694452221849, 6834.658267086526, 6866.313368663094, 6875.1749790025515, 6894.448444124559, 6940.27127151662, 6928.203256625351, 6950.096487456598, 6986.196587392515, 7036.366726994595, 7046.612436315847], "unit": "ms", "name": "mootools.html", "value": 4625.92391587759}, {"lowerIsBetter": false, "replicates": [357.1303875064218, 358.9874354397597, 360.877301717416, 360.90977255686084, 361.8353649089666, 6298.212723409574, 6360.968195159029, 6362.777302794403, 6369.681515924202, 6418.454431373327, 6180.381961803817, 6264.96867515663, 6344.904826427596, 6351.0, 6360.618362898218, 4884.291777692241, 4898.706077635354, 4902.877428064291, 4903.9754801225945, 4904.681195722284, 4896.31451596775, 4901.362822833027, 4904.75476226189, 4905.950940490585, 4907.043126590316, 4648.279516674921, 4811.855644330676, 4822.252550854606, 4832.516748325174, 4843.9515604843855, 4760.381150450419, 4792.281157826319, 4795.4724980252495, 4799.5440433158965, 4800.759962001904, 4157.729747566398, 4160.854370097032, 4163.562825903297, 4170.874873753793, 4181.811818468176, 5883.7058147092475, 5947.226860508106, 5954.166416701665, 5956.731947062349, 5968.432998865101, 5562.610617256793, 5574.498295153456, 5581.107022876361, 5585.804496842591, 5600.991821472134, 6633.2703402625675, 6643.0, 6645.767398141042, 6649.368310010541, 6664.200295964515, 4631.16639004979, 4632.444106707217, 4636.3045543168455, 4638.257878739386, 4660.487346391894, 6761.966190169067, 6868.896966545506, 6959.512834101615, 6961.26906674802, 6968.930310696879, 4704.670673052853, 4721.079389519079, 4729.314249433882, 4747.382840230748, 4750.738709371018, 4807.975960120177, 4819.0, 4830.589399900978, 4842.757862106881, 4849.2726091085915, 5624.353199382123, 5625.943740562542, 5628.2683251177905, 5636.323641163087, 5643.068893632505, 6652.966735166293, 6819.113515243086, 6829.692663830139, 6831.59010459374, 6835.453163746888, 1668.4827703411981, 1704.2671651190108, 1704.7101992661278, 1706.3771723321147, 1706.5136436115647, 1109.9001089901947, 1139.3334899083964, 1141.0757286597882, 1148.9138314626268, 1154.486253617149, 6464.612123272619, 6481.870362592722, 6509.088727578142, 6524.249711283168, 6535.673216339164, 6997.825054373579, 6998.125234345707, 6999.335063168991, 6999.335063169093, 7001.719931202695, 6408.743650253938, 6459.063435801782, 6491.870162596816, 6502.707378167994, 6508.381703738138, 3770.6606405423645, 3797.734158608926, 3800.0309920969976, 3800.5439347278502, 3805.1818858945458, 7132.572045677276, 7132.714691412285, 7135.1437827459995, 7146.2496437874315, 7159.427245820322, 6987.336203060701, 7147.142342918883, 7153.105861767279, 7157.355837974607, 7180.676869540779, 7118.537295075804, 7143.071400717978, 7148.642567871586, 7163.247858974837, 7177.461690373243, 6944.826379340557, 6973.651317434006, 6976.7558135465015, 6993.230744617987, 7008.439324853897, 6724.562903411263, 6858.0, 6883.518153729191, 6901.723931042702, 6931.930680693128, 7123.430125590044, 7142.285771423024, 7153.499255052305, 7174.569525828467, 7178.318059784312, 4796.784144713426, 4798.376211092535, 4802.543758342952, 4811.831585894477, 4814.759262036954, 6879.828004299732, 6936.583804971718, 6984.860302793814, 7011.894821577783, 7013.158420989514, 6737.25890152073, 6747.797566073025, 6784.5929244243525, 6790.049393085071, 6810.693518791567, 6725.8991115134295, 6759.053732477359, 6776.593404395752, 6786.423154031765, 6791.320867913169, 6532.8366790830605, 6639.634820084749, 6666.699998500176, 6679.632620205935, 6680.630470753581, 6741.764038258638, 6771.950347696115, 6804.0, 6806.047153398429, 6809.8638027238185, 6586.242582103119, 6616.470682345497, 6654.933450665431, 6658.267590564937, 6662.133922590032], "unit": "ms", "name": "prototype.html", "value": 5077.772343574913}, {"lowerIsBetter": false, "replicates": [763.8529259451062, 855.4995327733279, 900.1133883125125, 918.7565295196774, 932.9224745419041, 13529.458821647135, 13953.581392558226, 13980.510682126114, 14091.859081409182, 14156.575302740908, 13528.053036287463, 15024.098554086762, 15085.547433576983, 15207.46773862915, 15227.314770835339, 915.1946287267195, 916.5050872528826, 927.7680579855037, 945.4847108325979, 948.4735971535795, 931.5435436636068, 941.4304345870752, 941.9623215071389, 943.4527973775229, 945.3240932733095, 948.6015873333182, 964.6816550538306, 965.1217392173124, 967.1827305926481, 970.0, 942.9387089839207, 948.4451595816456, 951.1059603972244, 952.8570714392828, 955.1165172215707, 711.6619605687309, 712.0, 712.2521352579822, 714.1822613108014, 717.1573401253506, 13379.464821407131, 13480.05639605228, 13484.797728034087, 13498.257595832225, 13518.391672374766, 12242.0, 12680.55618053373, 12832.679183020406, 12953.417096230693, 13834.93082534591, 10435.79128417435, 10634.30876992993, 11386.373749443777, 11643.301401915913, 11766.588169414115, 3818.3317919364276, 3856.865009724674, 3905.433712111728, 3928.4303775952612, 3979.283728928792, 49900.50099498995, 49906.0, 50104.0, 50582.49417505815, 50629.746851265874, 10317.587296508205, 10372.481375931173, 10495.947520262349, 10536.315139515908, 10654.254202205771, 19693.507662308555, 19699.212031518866, 19782.70325945112, 20086.899565502077, 20096.799032009494, 8227.876581851277, 8291.08798032216, 8325.0, 8366.414350995494, 8390.916090839013, 4394.758288294174, 4405.383246345515, 4625.190591646448, 4654.16225079489, 4696.436427628706, 3193.2815116599045, 3209.069369882708, 3234.1591186291735, 3238.3037646906027, 3244.8215348156077, 553.195101127858, 565.8104534980828, 571.0891128649797, 572.6506830833189, 572.7336788393334, 725.3798002707714, 733.5561984999106, 742.1168809117133, 742.5322047110286, 742.9739959101405, 8488.872666910001, 8531.658733650584, 8567.785805354915, 8597.5701214939, 8598.78503037429, 693.3932808792307, 698.8238456216508, 726.23019599225, 742.7660287009575, 745.4371949178444, 4150.190712810973, 4224.683148763855, 4277.401163837066, 4301.462317210348, 4302.139572085533, 63600.68199658972, 63724.68137659375, 63741.681291593246, 64314.0, 64739.67630161913, 54090.729546352806, 54600.72699636476, 55248.72375638096, 55571.0, 55821.720891395285, 45162.774186129514, 45556.77221613871, 51783.74108129435, 52101.352905297026, 52136.99999999924, 9245.352825302165, 9252.444853308823, 9350.503919372868, 9561.426314420878, 9574.712758617252, 38154.80922595369, 38680.2263954725, 39034.0, 39207.80396098001, 39652.60347396489, 49760.0, 50153.74923125361, 50333.74833125811, 50682.493175069256, 50801.0, 12408.81386779181, 12480.812787808009, 12569.183003104768, 12580.685482863002, 12867.22796632205, 13168.144070635379, 13332.400041998328, 13414.262215577846, 13480.393382297623, 13995.650108747363, 11853.0, 12183.573574925189, 12703.745925081632, 12807.231566106064, 13117.212967221998, 11576.305421674726, 11587.884121159017, 11737.647870563897, 11801.40992950332, 11871.287722736663, 11896.84108084466, 11955.342456164646, 12147.635570932885, 12265.754684906073, 12483.875161248634, 9974.251931105051, 10053.547590358305, 10120.291579589359, 10129.89870101319, 10708.03627673513, 9662.613495460384, 9739.796605435346, 9786.706398808046, 9875.506224688594, 9905.108540231413], "unit": "ms", "name": "yui.html", "value": 6825.7767433250765}], "name": "dromaeo_css", "value": 7386.034082804282}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 105.0, 111.0, 111.0, 112.0, 122.0, 110.0, 110.0, 110.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [152.0, 133.0, 151.0, 156.0, 125.0, 151.0, 164.0, 124.0, 162.0, 122.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.0}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 162.0, 161.0, 162.0, 161.0, 163.0, 163.0, 162.0, 166.0], "unit": "ms", "name": "audio-dft", "value": 162.4}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 75.0, 174.0, 74.0, 71.0, 70.0, 72.0, 163.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 91.7}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 140.0, 92.0, 93.0, 93.0, 136.0, 91.0, 94.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 105.9}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [150.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 149.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 95.0, 96.0, 97.0, 96.0, 98.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 60.0, 62.0, 58.0, 58.0, 59.0, 60.0, 65.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 59.5}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 67.0, 64.0, 66.0, 65.0, 65.0, 64.0, 65.0, 65.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.0}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 82.0, 90.0, 87.0, 83.0, 89.0, 83.0, 82.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.2}, {"lowerIsBetter": true, "replicates": [120.0, 119.0, 126.0, 121.0, 116.0, 114.0, 119.0, 116.0, 115.0, 123.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 118.9}, {"lowerIsBetter": true, "replicates": [149.0, 145.0, 144.0, 137.0, 144.0, 146.0, 145.0, 145.0, 144.0, 145.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.4}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 65.0, 65.0, 69.0, 65.0, 65.0, 65.0, 65.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.0}], "name": "kraken", "value": 1506.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.0564650851988], "unit": "score", "name": "Richards", "value": 211.31777200000008}, {"lowerIsBetter": false, "replicates": [167.7008217340265], "unit": "score", "name": "DeltaBlue", "value": 394.26163399999996}, {"lowerIsBetter": false, "replicates": [279.6420581655481], "unit": "score", "name": "Encrypt", "value": 951.8632560000003}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [892.8571428571429], "unit": "score", "name": "RayTrace", "value": 828.7876800000003}, {"lowerIsBetter": false, "replicates": [552.4861878453039], "unit": "score", "name": "Earley", "value": 1206.29803}, {"lowerIsBetter": false, "replicates": [11517.241379310344], "unit": "score", "name": "Boyer", "value": 57.86654790419164}, {"lowerIsBetter": false, "replicates": [23857.14285714286], "unit": "score", "name": "RegExp", "value": 38.185}, {"lowerIsBetter": false, "replicates": [532.197977647685], "unit": "score", "name": "Splay", "value": 153.12158900000006}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 23129.10285292617}]} 06:11:36 INFO - RETURN: dromaeo_css: 7386.03 06:11:36 INFO - RETURN: kraken: 1506.30 06:11:36 INFO - RETURN: v8_7: 23129.10 06:11:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23129.10"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1506.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7386.03"}}} 06:11:36 INFO - Return code: 0 06:11:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:11:36 INFO - # TBPL SUCCESS # 06:11:36 INFO - Running post-action listener: _resource_record_post_action 06:11:36 INFO - Running post-run listener: _resource_record_post_run 06:11:37 INFO - Total resource usage - Wall time: 1222s; CPU: 13.0%; Read bytes: 8192; Write bytes: 512630784; Read time: 112; Write time: 406992 06:11:37 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 244363264; Read time: 0; Write time: 251612 06:11:37 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 8192; Write bytes: 264232960; Read time: 112; Write time: 154672 06:11:37 INFO - Running post-run listener: _upload_blobber_files 06:11:37 INFO - Blob upload gear active. 06:11:37 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:11:37 INFO - Copying logs to upload dir... 06:11:37 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1257.490562 ========= master_lag: 300.65 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 25 mins, 58 secs) (at 2016-01-25 06:16:37.490265) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-25 06:16:37.494193) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/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-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1453726832.279669-280590249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/pgZ1QC9cScidWMmi6Xh3Pg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010075 build_url: 'https://queue.taskcluster.net/v1/task/pgZ1QC9cScidWMmi6Xh3Pg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.38 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-25 06:16:37.886276) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-01-25 06:16:37.886676) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1453726832.279669-280590249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 5.27 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-01-25 06:16:43.162500) ========= ========= Started reboot skipped (results: 3, elapsed: 2 secs) (at 2016-01-25 06:16:43.162890) ========= ========= Finished reboot skipped (results: 3, elapsed: 2 secs) (at 2016-01-25 06:16:45.863780) ========= ========= Total master_lag: 306.48 =========