builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-051 starttime: 1478096314.66 results: success (0) buildid: 20161102061518 builduid: 7a5e126f4a644e87b5e00e29f1c4578b revision: 28ed60ea7e1117144e10ed931df1dfc9437dacbf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-02 07:18:34.658213) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-02 07:18:34.658786) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-02 07:18:34.659101) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-02 07:18:34.674122) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 07:18:34.674503) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1478096314.179477-1936371055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-02 07:18:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.0M=0s 2016-11-02 07:18:35 (43.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.090311 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 07:18:34.778967) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 07:18:34.779293) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1478096314.179477-1936371055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014950 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 07:18:34.829207) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 07:18:34.829561) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 28ed60ea7e1117144e10ed931df1dfc9437dacbf --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 28ed60ea7e1117144e10ed931df1dfc9437dacbf --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1478096314.179477-1936371055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-02 07:18:35,343 truncating revision to first 12 chars 2016-11-02 07:18:35,343 Setting DEBUG logging. 2016-11-02 07:18:35,343 attempt 1/10 2016-11-02 07:18:35,343 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/28ed60ea7e11?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-02 07:18:35,743 unpacking tar archive at: mozilla-inbound-28ed60ea7e11/testing/mozharness/ program finished with exit code 0 elapsedTime=0.751165 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 07:18:35.594384) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-02 07:18:35.594701) ========= script_repo_revision: 28ed60ea7e1117144e10ed931df1dfc9437dacbf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-02 07:18:35.595087) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-02 07:18:35.595349) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-02 07:18:35.606939) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-11-02 07:18:35.607446) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1478096314.179477-1936371055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:18:36 INFO - MultiFileLogger online at 20161102 07:18:36 in /builds/slave/test 07:18:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 07:18:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:18:36 INFO - {'append_to_log': False, 07:18:36 INFO - 'base_work_dir': '/builds/slave/test', 07:18:36 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:18:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:18:36 INFO - 'branch': 'Mozilla-Inbound', 07:18:36 INFO - 'buildbot_json_path': 'buildprops.json', 07:18:36 INFO - 'config_files': ('talos/linux_config.py',), 07:18:36 INFO - 'default_actions': ('clobber', 07:18:36 INFO - 'read-buildbot-config', 07:18:36 INFO - 'download-and-extract', 07:18:36 INFO - 'populate-webroot', 07:18:36 INFO - 'create-virtualenv', 07:18:36 INFO - 'install', 07:18:36 INFO - 'run-tests'), 07:18:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:18:36 INFO - 'download_minidump_stackwalk': True, 07:18:36 INFO - 'download_symbols': 'ondemand', 07:18:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:18:36 INFO - 'tooltool.py': '/tools/tooltool.py', 07:18:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:18:36 INFO - '/tools/misc-python/virtualenv.py')}, 07:18:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:18:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:18:36 INFO - 'installer_path': 'installer.exe', 07:18:36 INFO - 'log_level': 'info', 07:18:36 INFO - 'log_name': 'talos', 07:18:36 INFO - 'log_to_console': True, 07:18:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:18:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:18:36 INFO - 'opt_config_files': (), 07:18:36 INFO - 'pip_index': False, 07:18:36 INFO - 'sps_profile': False, 07:18:36 INFO - 'sps_profile_interval': 0, 07:18:36 INFO - 'suite': 'dromaeojs', 07:18:36 INFO - 'system_bits': '32', 07:18:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:18:36 INFO - 'title': 'talos-linux64-ix-051', 07:18:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:18:36 INFO - 'use_talos_json': True, 07:18:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:18:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:18:36 INFO - 'work_dir': 'build'} 07:18:36 INFO - [mozharness: 2016-11-02 14:18:36.213902Z] Running clobber step. 07:18:36 INFO - Running pre-action listener: _resource_record_pre_action 07:18:36 INFO - Running main action method: clobber 07:18:36 INFO - rmtree: /builds/slave/test/build 07:18:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:18:36 INFO - Running post-action listener: _resource_record_post_action 07:18:36 INFO - [mozharness: 2016-11-02 14:18:36.669388Z] Finished clobber step (success) 07:18:36 INFO - [mozharness: 2016-11-02 14:18:36.669501Z] Running read-buildbot-config step. 07:18:36 INFO - Running pre-action listener: _resource_record_pre_action 07:18:36 INFO - Running main action method: read_buildbot_config 07:18:36 INFO - Using buildbot properties: 07:18:36 INFO - { 07:18:36 INFO - "project": "", 07:18:36 INFO - "product": "firefox", 07:18:36 INFO - "script_repo_revision": "production", 07:18:36 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 07:18:36 INFO - "repository": "", 07:18:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 07:18:36 INFO - "buildid": "20161102061518", 07:18:36 INFO - "stage_platform": "linux64-pgo", 07:18:36 INFO - "basedir": "/builds/slave/test", 07:18:36 INFO - "buildnumber": 1955, 07:18:36 INFO - "platform": "ubuntu64_hw", 07:18:36 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:18:36 INFO - "slavebuilddir": "test", 07:18:36 INFO - "branch": "mozilla-inbound", 07:18:36 INFO - "revision": "28ed60ea7e1117144e10ed931df1dfc9437dacbf", 07:18:36 INFO - "slavename": "talos-linux64-ix-051", 07:18:36 INFO - "builduid": "7a5e126f4a644e87b5e00e29f1c4578b", 07:18:36 INFO - "repo_path": "integration/mozilla-inbound" 07:18:36 INFO - } 07:18:36 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478061457/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 07:18:36 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478061457/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 07:18:36 INFO - Running post-action listener: _resource_record_post_action 07:18:36 INFO - [mozharness: 2016-11-02 14:18:36.671834Z] Finished read-buildbot-config step (success) 07:18:36 INFO - [mozharness: 2016-11-02 14:18:36.671920Z] Running download-and-extract step. 07:18:36 INFO - Running pre-action listener: _resource_record_pre_action 07:18:36 INFO - Running main action method: download_and_extract 07:18:36 INFO - mkdir: /builds/slave/test/build/tests 07:18:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:36 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478061457/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:18:36 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478061457/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:18:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478061457/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:18:36 INFO - Downloaded 1361 bytes. 07:18:36 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:18:36 INFO - Using the following test package requirements: 07:18:36 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 07:18:36 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:18:36 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:18:36 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:18:36 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:18:36 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:18:36 INFO - u'jsshell-linux-x86_64.zip'], 07:18:36 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:18:36 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:18:36 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 07:18:36 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:18:36 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:18:36 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:18:36 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:18:36 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:18:36 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:18:36 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:18:36 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:18:36 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:18:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478061457/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 07:18:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478061457/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:18:36 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478061457/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:18:36 INFO - Http code: 200 07:18:36 INFO - via: 1.1 0576b942ae9f4fc9c0b62b0736e9bfd6.cloudfront.net (CloudFront) 07:18:36 INFO - x-amz-cf-id: NFrypSxoViqeqv6wm86XRzxb-ngxAL7-CTGpsbCbd7H1FuNPmJYyeg== 07:18:36 INFO - x-amz-replication-status: COMPLETED 07:18:36 INFO - x-amz-version-id: U4NGjytpgCRHCs0MGIrblnuacidlz5AH 07:18:37 INFO - Expected file size: 22019856 07:18:37 INFO - Obtained file size: 22019856 07:18:41 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:18:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478061457/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 07:18:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478061457/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:18:41 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478061457/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:18:41 INFO - Http code: 200 07:18:41 INFO - via: 1.1 5574699f9d8b8aad21acf2edbb25dc62.cloudfront.net (CloudFront) 07:18:41 INFO - x-amz-cf-id: yT-qN4seoncfYFSCiynljxDKje4x6iZXBHYqpiG9N_TJGwI1mI9GFA== 07:18:41 INFO - x-amz-replication-status: COMPLETED 07:18:41 INFO - x-amz-version-id: U4NGjytpgCRHCs0MGIrblnuacidlz5AH 07:18:41 INFO - Expected file size: 22019856 07:18:41 INFO - Obtained file size: 22019856 07:18:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478061457/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 07:18:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478061457/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:18:45 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478061457/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:18:45 INFO - Http code: 200 07:18:45 INFO - via: 1.1 8e86372eaaa62fc64b70e7bcde725dd9.cloudfront.net (CloudFront) 07:18:45 INFO - x-amz-cf-id: R6foEdeGgT7AqRuz3HRl-8Tsc3vCNPZ_clQYZqw2GRTRUWcf3J3Bqg== 07:18:45 INFO - x-amz-replication-status: COMPLETED 07:18:45 INFO - x-amz-version-id: N5DqssezedrcZDCOJ8iAUU9lqTUIwWHE 07:18:46 INFO - Expected file size: 14409038 07:18:46 INFO - Obtained file size: 14409038 07:18: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:46 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478061457/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:18:46 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478061457/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:18:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478061457/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:18:47 INFO - Downloaded 59612733 bytes. 07:18:47 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478061457/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:18:47 INFO - mkdir: /builds/slave/test/properties 07:18:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:18:47 INFO - Writing to file /builds/slave/test/properties/build_url 07:18:47 INFO - Contents: 07:18:47 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478061457/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:18:47 INFO - Running post-action listener: _resource_record_post_action 07:18:47 INFO - Running post-action listener: set_extra_try_arguments 07:18:47 INFO - [mozharness: 2016-11-02 14:18:47.506508Z] Finished download-and-extract step (success) 07:18:47 INFO - [mozharness: 2016-11-02 14:18:47.506734Z] Running populate-webroot step. 07:18:47 INFO - Running pre-action listener: _resource_record_pre_action 07:18:47 INFO - Running main action method: populate_webroot 07:18:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:18:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:18:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:18:47 INFO - '--tppagecycles', 07:18:47 INFO - '7'], 07:18:47 INFO - 'tests': ['tsvgm']}}, 07:18:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:18:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:18:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:18:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:18:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:18:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:18:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:47 INFO - 'talos_options': ['--disable-e10s'], 07:18:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:18:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:18:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:47 INFO - 'talos_options': ['--disable-e10s'], 07:18:47 INFO - 'tests': ['damp', 'tps']}, 07:18:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:47 INFO - 'tests': ['damp', 'tps']}, 07:18:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:18:47 INFO - 'tests': ['dromaeo_dom']}, 07:18:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:18:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:18:47 INFO - 'tests': ['basic_compositor_video']}, 07:18:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:18:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:18:47 INFO - 'tests': ['a11yr', 07:18:47 INFO - 'ts_paint', 07:18:47 INFO - 'tpaint', 07:18:47 INFO - 'sessionrestore', 07:18:47 INFO - 'sessionrestore_no_auto_restore', 07:18:47 INFO - 'tabpaint']}, 07:18:47 INFO - 'other-e10s': {'tests': ['a11yr', 07:18:47 INFO - 'ts_paint', 07:18:47 INFO - 'tpaint', 07:18:47 INFO - 'sessionrestore', 07:18:47 INFO - 'sessionrestore_no_auto_restore', 07:18:47 INFO - 'tabpaint']}, 07:18:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:18:47 INFO - 'ts_paint', 07:18:47 INFO - 'tpaint', 07:18:47 INFO - 'sessionrestore', 07:18:47 INFO - 'sessionrestore_no_auto_restore', 07:18:47 INFO - 'tabpaint']}, 07:18:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:18:47 INFO - 'ts_paint', 07:18:47 INFO - 'tpaint', 07:18:47 INFO - 'sessionrestore', 07:18:47 INFO - 'sessionrestore_no_auto_restore', 07:18:47 INFO - 'tabpaint']}, 07:18:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:18:47 INFO - 'tests': ['a11yr', 07:18:47 INFO - 'ts_paint', 07:18:47 INFO - 'tpaint', 07:18:47 INFO - 'sessionrestore', 07:18:47 INFO - 'sessionrestore_no_auto_restore', 07:18:47 INFO - 'tabpaint']}, 07:18:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:18:47 INFO - 'tests': ['a11yr', 07:18:47 INFO - 'ts_paint', 07:18:47 INFO - 'tpaint', 07:18:47 INFO - 'sessionrestore', 07:18:47 INFO - 'sessionrestore_no_auto_restore', 07:18:47 INFO - 'tabpaint']}, 07:18:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:18:47 INFO - 'tests': ['tsvgx', 07:18:47 INFO - 'tsvgr_opacity', 07:18:47 INFO - 'tart', 07:18:47 INFO - 'tscrollx', 07:18:47 INFO - 'cart']}, 07:18:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:18:47 INFO - 'tsvgr_opacity', 07:18:47 INFO - 'tart', 07:18:47 INFO - 'tscrollx', 07:18:47 INFO - 'cart']}, 07:18:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:47 INFO - 'talos_options': ['--disable-e10s'], 07:18:47 INFO - 'tests': ['tp5o']}, 07:18:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:47 INFO - 'tests': ['tp5o']}, 07:18:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:47 INFO - 'talos_options': ['--disable-e10s', 07:18:47 INFO - '--xperf_path', 07:18:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:18:47 INFO - 'tests': ['tp5n']}, 07:18:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:47 INFO - 'talos_options': ['--xperf_path', 07:18:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:18:47 INFO - 'tests': ['tp5n']}}, 07:18:47 INFO - 'talos.zip': {'path': '', 07:18:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:18:47 INFO - Running post-action listener: _resource_record_post_action 07:18:47 INFO - [mozharness: 2016-11-02 14:18:47.524271Z] Finished populate-webroot step (success) 07:18:47 INFO - [mozharness: 2016-11-02 14:18:47.524358Z] Running create-virtualenv step. 07:18:47 INFO - Running pre-action listener: _resource_record_pre_action 07:18:47 INFO - Running main action method: create_virtualenv 07:18:47 INFO - Creating virtualenv /builds/slave/test/build/venv 07:18:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:18:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:18:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:18:47 INFO - Using real prefix '/usr' 07:18:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:18:48 INFO - Installing distribute.............................................................................................................................................................................................done. 07:18:50 INFO - Installing pip.................done. 07:18:50 INFO - Return code: 0 07:18:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:18:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:18:50 INFO - Reading from file tmpfile_stdout 07:18:50 INFO - Output received: 07:18:50 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:18:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f26353cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1f60>, '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 0x1ff2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1478096314.179477-1936371055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:18:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:18:50 INFO - Using env: {'DISPLAY': ':0', 07:18:50 INFO - 'HOME': '/home/cltbld', 07:18:50 INFO - 'LANG': 'en_US.UTF-8', 07:18:50 INFO - 'LANGUAGE': 'en_US:en', 07:18:50 INFO - 'LOGNAME': 'cltbld', 07:18:50 INFO - 'MAIL': '/var/mail/cltbld', 07:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:50 INFO - 'MOZ_NO_REMOTE': '1', 07:18:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:50 INFO - 'NO_EM_RESTART': '1', 07:18:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:50 INFO - 'PWD': '/builds/slave/test', 07:18:50 INFO - 'SHELL': '/bin/bash', 07:18:50 INFO - 'SHLVL': '1', 07:18:50 INFO - 'TERM': 'linux', 07:18:50 INFO - 'TMOUT': '86400', 07:18:50 INFO - 'USER': 'cltbld', 07:18:50 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1478096314.179477-1936371055', 07:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:50 INFO - '_': '/tools/buildbot/bin/python'} 07:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:50 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 07:18:50 INFO - Cleaning up... 07:18:50 INFO - Return code: 0 07:18:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f26353cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1f60>, '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 0x1ff2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1478096314.179477-1936371055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:18:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:18:50 INFO - Using env: {'DISPLAY': ':0', 07:18:50 INFO - 'HOME': '/home/cltbld', 07:18:50 INFO - 'LANG': 'en_US.UTF-8', 07:18:50 INFO - 'LANGUAGE': 'en_US:en', 07:18:50 INFO - 'LOGNAME': 'cltbld', 07:18:50 INFO - 'MAIL': '/var/mail/cltbld', 07:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:50 INFO - 'MOZ_NO_REMOTE': '1', 07:18:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:50 INFO - 'NO_EM_RESTART': '1', 07:18:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:50 INFO - 'PWD': '/builds/slave/test', 07:18:50 INFO - 'SHELL': '/bin/bash', 07:18:50 INFO - 'SHLVL': '1', 07:18:50 INFO - 'TERM': 'linux', 07:18:50 INFO - 'TMOUT': '86400', 07:18:50 INFO - 'USER': 'cltbld', 07:18:50 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1478096314.179477-1936371055', 07:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:50 INFO - '_': '/tools/buildbot/bin/python'} 07:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:50 INFO - Downloading/unpacking psutil>=3.1.1 07:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:18:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:18:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:18:52 INFO - Installing collected packages: psutil 07:18:52 INFO - Running setup.py install for psutil 07:18:52 INFO - building 'psutil._psutil_linux' extension 07:18:52 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 07:18:52 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 07:18:53 INFO - building 'psutil._psutil_posix' extension 07:18:53 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 07:18:53 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 07:18:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:18:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:18:53 INFO - Successfully installed psutil 07:18:53 INFO - Cleaning up... 07:18:53 INFO - Return code: 0 07:18:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:18:53 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:53 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f26353cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1f60>, '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 0x1ff2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1478096314.179477-1936371055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:18:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:18:53 INFO - Using env: {'DISPLAY': ':0', 07:18:53 INFO - 'HOME': '/home/cltbld', 07:18:53 INFO - 'LANG': 'en_US.UTF-8', 07:18:53 INFO - 'LANGUAGE': 'en_US:en', 07:18:53 INFO - 'LOGNAME': 'cltbld', 07:18:53 INFO - 'MAIL': '/var/mail/cltbld', 07:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:53 INFO - 'MOZ_NO_REMOTE': '1', 07:18:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:53 INFO - 'NO_EM_RESTART': '1', 07:18:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:53 INFO - 'PWD': '/builds/slave/test', 07:18:53 INFO - 'SHELL': '/bin/bash', 07:18:53 INFO - 'SHLVL': '1', 07:18:53 INFO - 'TERM': 'linux', 07:18:53 INFO - 'TMOUT': '86400', 07:18:53 INFO - 'USER': 'cltbld', 07:18:53 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1478096314.179477-1936371055', 07:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:53 INFO - '_': '/tools/buildbot/bin/python'} 07:18:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:18:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:18:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:18:55 INFO - Installing collected packages: mozsystemmonitor 07:18:55 INFO - Running setup.py install for mozsystemmonitor 07:18:55 INFO - Successfully installed mozsystemmonitor 07:18:55 INFO - Cleaning up... 07:18:55 INFO - Return code: 0 07:18:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:18: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f26353cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1f60>, '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 0x1ff2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1478096314.179477-1936371055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:18:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:18:55 INFO - Using env: {'DISPLAY': ':0', 07:18:55 INFO - 'HOME': '/home/cltbld', 07:18:55 INFO - 'LANG': 'en_US.UTF-8', 07:18:55 INFO - 'LANGUAGE': 'en_US:en', 07:18:55 INFO - 'LOGNAME': 'cltbld', 07:18:55 INFO - 'MAIL': '/var/mail/cltbld', 07:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:55 INFO - 'MOZ_NO_REMOTE': '1', 07:18:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:55 INFO - 'NO_EM_RESTART': '1', 07:18:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:55 INFO - 'PWD': '/builds/slave/test', 07:18:55 INFO - 'SHELL': '/bin/bash', 07:18:55 INFO - 'SHLVL': '1', 07:18:55 INFO - 'TERM': 'linux', 07:18:55 INFO - 'TMOUT': '86400', 07:18:55 INFO - 'USER': 'cltbld', 07:18:55 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1478096314.179477-1936371055', 07:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:55 INFO - '_': '/tools/buildbot/bin/python'} 07:18:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:55 INFO - Downloading/unpacking jsonschema==2.5.1 07:18: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 07:18: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 07:18: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 07:18: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 07:18: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 07:18: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 07:18:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:18:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:18: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 07:18: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 07:18: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 07:18: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 07:18: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 07:18: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 07:18:57 INFO - Downloading functools32-3.2.3-2.tar.gz 07:18:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:18:58 INFO - warning: no files found matching '*.txt' 07:18:58 INFO - no previously-included directories found matching 'build' 07:18:58 INFO - no previously-included directories found matching 'dist' 07:18:58 INFO - no previously-included directories found matching '.git*' 07:18:58 INFO - Installing collected packages: jsonschema, functools32 07:18:58 INFO - Running setup.py install for functools32 07:18:58 INFO - warning: no files found matching '*.txt' 07:18:58 INFO - no previously-included directories found matching 'build' 07:18:58 INFO - no previously-included directories found matching 'dist' 07:18:58 INFO - no previously-included directories found matching '.git*' 07:18:58 INFO - Successfully installed jsonschema functools32 07:18:58 INFO - Cleaning up... 07:18:58 INFO - Return code: 0 07:18:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:18:58 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:58 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f26353cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1f60>, '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 0x1ff2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1478096314.179477-1936371055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:18:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:18:58 INFO - Using env: {'DISPLAY': ':0', 07:18:58 INFO - 'HOME': '/home/cltbld', 07:18:58 INFO - 'LANG': 'en_US.UTF-8', 07:18:58 INFO - 'LANGUAGE': 'en_US:en', 07:18:58 INFO - 'LOGNAME': 'cltbld', 07:18:58 INFO - 'MAIL': '/var/mail/cltbld', 07:18:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:58 INFO - 'MOZ_NO_REMOTE': '1', 07:18:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:58 INFO - 'NO_EM_RESTART': '1', 07:18:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:58 INFO - 'PWD': '/builds/slave/test', 07:18:58 INFO - 'SHELL': '/bin/bash', 07:18:58 INFO - 'SHLVL': '1', 07:18:58 INFO - 'TERM': 'linux', 07:18:58 INFO - 'TMOUT': '86400', 07:18:58 INFO - 'USER': 'cltbld', 07:18:58 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1478096314.179477-1936371055', 07:18:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:58 INFO - '_': '/tools/buildbot/bin/python'} 07:18:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:18:58 INFO - Cleaning up... 07:18:58 INFO - Return code: 0 07:18:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:18:58 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:58 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f26353cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1f60>, '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 0x1ff2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1478096314.179477-1936371055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:18:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:18:58 INFO - Using env: {'DISPLAY': ':0', 07:18:58 INFO - 'HOME': '/home/cltbld', 07:18:58 INFO - 'LANG': 'en_US.UTF-8', 07:18:58 INFO - 'LANGUAGE': 'en_US:en', 07:18:58 INFO - 'LOGNAME': 'cltbld', 07:18:58 INFO - 'MAIL': '/var/mail/cltbld', 07:18:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:58 INFO - 'MOZ_NO_REMOTE': '1', 07:18:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:58 INFO - 'NO_EM_RESTART': '1', 07:18:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:58 INFO - 'PWD': '/builds/slave/test', 07:18:58 INFO - 'SHELL': '/bin/bash', 07:18:58 INFO - 'SHLVL': '1', 07:18:58 INFO - 'TERM': 'linux', 07:18:58 INFO - 'TMOUT': '86400', 07:18:58 INFO - 'USER': 'cltbld', 07:18:58 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1478096314.179477-1936371055', 07:18:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:58 INFO - '_': '/tools/buildbot/bin/python'} 07:18:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:58 INFO - Downloading/unpacking blobuploader==1.2.4 07:18:58 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 07:18:58 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 07:18:58 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 07:18:58 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 07:18:58 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 07:18:58 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 07:19:00 INFO - Downloading blobuploader-1.2.4.tar.gz 07:19:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:19:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:19:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:01 INFO - Downloading docopt-0.6.1.tar.gz 07:19:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:19:01 INFO - Installing collected packages: blobuploader, requests, docopt 07:19:01 INFO - Running setup.py install for blobuploader 07:19:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:19:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:19:01 INFO - Running setup.py install for requests 07:19:01 INFO - Running setup.py install for docopt 07:19:01 INFO - Successfully installed blobuploader requests docopt 07:19:01 INFO - Cleaning up... 07:19:02 INFO - Return code: 0 07:19:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f26353cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1f60>, '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 0x1ff2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1478096314.179477-1936371055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:19:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:19:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:19:02 INFO - Using env: {'DISPLAY': ':0', 07:19:02 INFO - 'HOME': '/home/cltbld', 07:19:02 INFO - 'LANG': 'en_US.UTF-8', 07:19:02 INFO - 'LANGUAGE': 'en_US:en', 07:19:02 INFO - 'LOGNAME': 'cltbld', 07:19:02 INFO - 'MAIL': '/var/mail/cltbld', 07:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:02 INFO - 'MOZ_NO_REMOTE': '1', 07:19:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:02 INFO - 'NO_EM_RESTART': '1', 07:19:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:02 INFO - 'PWD': '/builds/slave/test', 07:19:02 INFO - 'SHELL': '/bin/bash', 07:19:02 INFO - 'SHLVL': '1', 07:19:02 INFO - 'TERM': 'linux', 07:19:02 INFO - 'TMOUT': '86400', 07:19:02 INFO - 'USER': 'cltbld', 07:19:02 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1478096314.179477-1936371055', 07:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:02 INFO - '_': '/tools/buildbot/bin/python'} 07:19:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:19:02 INFO - Running setup.py (path:/tmp/pip-WdzVkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:19:02 INFO - Running setup.py (path:/tmp/pip-Zq2S39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:19:02 INFO - Running setup.py (path:/tmp/pip-eNe1Lm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:19:02 INFO - Running setup.py (path:/tmp/pip-AD8DwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:19:02 INFO - Running setup.py (path:/tmp/pip-ZNbC8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:19:02 INFO - Running setup.py (path:/tmp/pip-dyVaV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:19:02 INFO - Running setup.py (path:/tmp/pip-c6y9iz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:19:02 INFO - Running setup.py (path:/tmp/pip-FgpN0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:19:02 INFO - Running setup.py (path:/tmp/pip-cJ0Fw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:19:02 INFO - Running setup.py (path:/tmp/pip-jR042M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:19:02 INFO - Running setup.py (path:/tmp/pip-Wv3drl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:19:03 INFO - Running setup.py (path:/tmp/pip-n_lwMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:19:03 INFO - Running setup.py (path:/tmp/pip-3niOfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:19:03 INFO - Running setup.py (path:/tmp/pip-5FOWmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:03 INFO - Running setup.py (path:/tmp/pip-XquE8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:19:03 INFO - Running setup.py (path:/tmp/pip-q0Bf4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:19:03 INFO - Running setup.py (path:/tmp/pip-7UoD3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:19:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:19:03 INFO - Running setup.py install for manifestparser 07:19:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:19:03 INFO - Running setup.py install for mozcrash 07:19:03 INFO - Running setup.py install for mozdebug 07:19:03 INFO - Running setup.py install for mozdevice 07:19:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:19:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:19:03 INFO - Running setup.py install for mozfile 07:19:03 INFO - Running setup.py install for mozhttpd 07:19:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:19:04 INFO - Running setup.py install for mozinfo 07:19:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:19:04 INFO - Running setup.py install for mozInstall 07:19:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:19:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:19:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:19:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:19:04 INFO - Running setup.py install for mozleak 07:19:04 INFO - Running setup.py install for mozlog 07:19:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:19:04 INFO - Running setup.py install for moznetwork 07:19:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:19:04 INFO - Running setup.py install for mozprocess 07:19:04 INFO - Running setup.py install for mozprofile 07:19:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:19:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:19:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:19:04 INFO - Running setup.py install for mozrunner 07:19:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:19:04 INFO - Running setup.py install for mozscreenshot 07:19:05 INFO - Running setup.py install for moztest 07:19:05 INFO - Running setup.py install for mozversion 07:19:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:19:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:19:05 INFO - Cleaning up... 07:19:05 INFO - Return code: 0 07:19:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f26353cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1f60>, '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 0x1ff2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1478096314.179477-1936371055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:19:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:19:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:19:05 INFO - Using env: {'DISPLAY': ':0', 07:19:05 INFO - 'HOME': '/home/cltbld', 07:19:05 INFO - 'LANG': 'en_US.UTF-8', 07:19:05 INFO - 'LANGUAGE': 'en_US:en', 07:19:05 INFO - 'LOGNAME': 'cltbld', 07:19:05 INFO - 'MAIL': '/var/mail/cltbld', 07:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:05 INFO - 'MOZ_NO_REMOTE': '1', 07:19:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:05 INFO - 'NO_EM_RESTART': '1', 07:19:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:05 INFO - 'PWD': '/builds/slave/test', 07:19:05 INFO - 'SHELL': '/bin/bash', 07:19:05 INFO - 'SHLVL': '1', 07:19:05 INFO - 'TERM': 'linux', 07:19:05 INFO - 'TMOUT': '86400', 07:19:05 INFO - 'USER': 'cltbld', 07:19:05 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1478096314.179477-1936371055', 07:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:05 INFO - '_': '/tools/buildbot/bin/python'} 07:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:19:05 INFO - Running setup.py (path:/tmp/pip-owHA1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:19:05 INFO - Running setup.py (path:/tmp/pip-avlYBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:19:05 INFO - Running setup.py (path:/tmp/pip-651AEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:19:05 INFO - Running setup.py (path:/tmp/pip-AYqfv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:19:05 INFO - Running setup.py (path:/tmp/pip-9W3kGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:19:05 INFO - Running setup.py (path:/tmp/pip-4ocK2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:19:05 INFO - Running setup.py (path:/tmp/pip-MrS5WK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:19:05 INFO - Running setup.py (path:/tmp/pip-wRGUvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:19:06 INFO - Running setup.py (path:/tmp/pip-3QeDtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:19:06 INFO - Running setup.py (path:/tmp/pip-DAq6n0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:19:06 INFO - Running setup.py (path:/tmp/pip-FlfYdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:19:06 INFO - Running setup.py (path:/tmp/pip-rgv1av-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:19:06 INFO - Running setup.py (path:/tmp/pip-tQvx_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:19:06 INFO - Running setup.py (path:/tmp/pip-GqgDEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:06 INFO - Running setup.py (path:/tmp/pip-EruAVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:19:06 INFO - Running setup.py (path:/tmp/pip-JDiInK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:19:06 INFO - Running setup.py (path:/tmp/pip-7P58Fu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:19:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:08 INFO - Downloading blessings-1.6.tar.gz 07:19:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:19:08 INFO - Installing collected packages: blessings 07:19:08 INFO - Running setup.py install for blessings 07:19:08 INFO - Successfully installed blessings 07:19:08 INFO - Cleaning up... 07:19:08 INFO - Return code: 0 07:19:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:19:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:19:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:19:09 INFO - Reading from file tmpfile_stdout 07:19:09 INFO - Current package versions: 07:19:09 INFO - argparse == 1.2.1 07:19:09 INFO - blessings == 1.6 07:19:09 INFO - blobuploader == 1.2.4 07:19:09 INFO - docopt == 0.6.1 07:19:09 INFO - functools32 == 3.2.3-2 07:19:09 INFO - jsonschema == 2.5.1 07:19:09 INFO - manifestparser == 1.1 07:19:09 INFO - mozInstall == 1.12 07:19:09 INFO - mozcrash == 0.17 07:19:09 INFO - mozdebug == 0.1 07:19:09 INFO - mozdevice == 0.48 07:19:09 INFO - mozfile == 1.2 07:19:09 INFO - mozhttpd == 0.7 07:19:09 INFO - mozinfo == 0.9 07:19:09 INFO - mozleak == 0.1 07:19:09 INFO - mozlog == 3.4 07:19:09 INFO - moznetwork == 0.27 07:19:09 INFO - mozprocess == 0.23 07:19:09 INFO - mozprofile == 0.28 07:19:09 INFO - mozrunner == 6.12 07:19:09 INFO - mozscreenshot == 0.1 07:19:09 INFO - mozsystemmonitor == 0.3 07:19:09 INFO - moztest == 0.7 07:19:09 INFO - mozversion == 1.4 07:19:09 INFO - psutil == 3.1.1 07:19:09 INFO - requests == 1.2.3 07:19:09 INFO - wsgiref == 0.1.2 07:19:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f26353cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1f60>, '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 0x1ff2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1478096314.179477-1936371055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:19:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:19:09 INFO - Using env: {'DISPLAY': ':0', 07:19:09 INFO - 'HOME': '/home/cltbld', 07:19:09 INFO - 'LANG': 'en_US.UTF-8', 07:19:09 INFO - 'LANGUAGE': 'en_US:en', 07:19:09 INFO - 'LOGNAME': 'cltbld', 07:19:09 INFO - 'MAIL': '/var/mail/cltbld', 07:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:09 INFO - 'MOZ_NO_REMOTE': '1', 07:19:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:09 INFO - 'NO_EM_RESTART': '1', 07:19:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:09 INFO - 'PWD': '/builds/slave/test', 07:19:09 INFO - 'SHELL': '/bin/bash', 07:19:09 INFO - 'SHLVL': '1', 07:19:09 INFO - 'TERM': 'linux', 07:19:09 INFO - 'TMOUT': '86400', 07:19:09 INFO - 'USER': 'cltbld', 07:19:09 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1478096314.179477-1936371055', 07:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:09 INFO - '_': '/tools/buildbot/bin/python'} 07:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:19:09 INFO - Cleaning up... 07:19:09 INFO - Return code: 0 07:19:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f26353cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1f60>, '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 0x1ff2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1478096314.179477-1936371055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:19:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:19:09 INFO - Using env: {'DISPLAY': ':0', 07:19:09 INFO - 'HOME': '/home/cltbld', 07:19:09 INFO - 'LANG': 'en_US.UTF-8', 07:19:09 INFO - 'LANGUAGE': 'en_US:en', 07:19:09 INFO - 'LOGNAME': 'cltbld', 07:19:09 INFO - 'MAIL': '/var/mail/cltbld', 07:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:09 INFO - 'MOZ_NO_REMOTE': '1', 07:19:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:09 INFO - 'NO_EM_RESTART': '1', 07:19:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:09 INFO - 'PWD': '/builds/slave/test', 07:19:09 INFO - 'SHELL': '/bin/bash', 07:19:09 INFO - 'SHLVL': '1', 07:19:09 INFO - 'TERM': 'linux', 07:19:09 INFO - 'TMOUT': '86400', 07:19:09 INFO - 'USER': 'cltbld', 07:19:09 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1478096314.179477-1936371055', 07:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:09 INFO - '_': '/tools/buildbot/bin/python'} 07:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:19:09 INFO - Cleaning up... 07:19:09 INFO - Return code: 0 07:19:09 INFO - Running post-action listener: _resource_record_post_action 07:19:09 INFO - Running post-action listener: _start_resource_monitoring 07:19:09 INFO - Starting resource monitoring. 07:19:09 INFO - [mozharness: 2016-11-02 14:19:09.634527Z] Finished create-virtualenv step (success) 07:19:09 INFO - [mozharness: 2016-11-02 14:19:09.634986Z] Running install step. 07:19:09 INFO - Running pre-action listener: _resource_record_pre_action 07:19:09 INFO - Running main action method: install 07:19:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:19:09 INFO - Reading from file tmpfile_stdout 07:19:09 INFO - Detecting whether we're running mozinstall >=1.0... 07:19:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:19:09 INFO - Reading from file tmpfile_stdout 07:19:09 INFO - Output received: 07:19:09 INFO - Usage: mozinstall [options] installer 07:19:09 INFO - Options: 07:19:09 INFO - -h, --help show this help message and exit 07:19:09 INFO - -d DEST, --destination=DEST 07:19:09 INFO - Directory to install application into. [default: 07:19:09 INFO - "/builds/slave/test"] 07:19:09 INFO - --app=APP Application being installed. [default: firefox] 07:19:09 INFO - mkdir: /builds/slave/test/build/application 07:19:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:19:26 INFO - Reading from file tmpfile_stdout 07:19:26 INFO - Output received: 07:19:26 INFO - /builds/slave/test/build/application/firefox/firefox 07:19:26 INFO - Running post-action listener: _resource_record_post_action 07:19:26 INFO - [mozharness: 2016-11-02 14:19:26.896405Z] Finished install step (success) 07:19:26 INFO - [mozharness: 2016-11-02 14:19:26.896682Z] Running run-tests step. 07:19:26 INFO - Running pre-action listener: _resource_record_pre_action 07:19:26 INFO - Running main action method: run_tests 07:19:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:19:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:19:26 INFO - Python 2.7.3 07:19:26 INFO - Return code: 0 07:19:26 INFO - grabbing minidump binary from tooltool 07:19:26 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:26 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1f60>, '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 0x1ff2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff31d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:19:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:19:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:19:26 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:19:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:19:26 INFO - Return code: 0 07:19:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:19:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:19:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:19:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:19:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:19:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478061457/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:19:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478061457/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:19:26 INFO - Using env: {'DISPLAY': ':0', 07:19:26 INFO - 'HOME': '/home/cltbld', 07:19:26 INFO - 'LANG': 'en_US.UTF-8', 07:19:26 INFO - 'LANGUAGE': 'en_US:en', 07:19:26 INFO - 'LOGNAME': 'cltbld', 07:19:26 INFO - 'MAIL': '/var/mail/cltbld', 07:19:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:19:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:19:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:26 INFO - 'MOZ_NO_REMOTE': '1', 07:19:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:19:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:26 INFO - 'NO_EM_RESTART': '1', 07:19:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:26 INFO - 'PWD': '/builds/slave/test', 07:19:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:19:26 INFO - 'SHELL': '/bin/bash', 07:19:26 INFO - 'SHLVL': '1', 07:19:26 INFO - 'TERM': 'linux', 07:19:26 INFO - 'TMOUT': '86400', 07:19:26 INFO - 'USER': 'cltbld', 07:19:26 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1478096314.179477-1936371055', 07:19:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:26 INFO - '_': '/tools/buildbot/bin/python'} 07:19:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478061457/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:19:27 INFO - mozversion application_buildid: 20161101213737 07:19:27 INFO - mozversion application_changeset: 28ed60ea7e1117144e10ed931df1dfc9437dacbf 07:19:27 INFO - mozversion application_display_name: Nightly 07:19:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:19:27 INFO - mozversion application_name: Firefox 07:19:27 INFO - mozversion application_remotingname: firefox 07:19:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:19:27 INFO - mozversion application_vendor: Mozilla 07:19:27 INFO - mozversion application_version: 52.0a1 07:19:27 INFO - mozversion platform_buildid: 20161101213737 07:19:27 INFO - mozversion platform_changeset: 28ed60ea7e1117144e10ed931df1dfc9437dacbf 07:19:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:19:27 INFO - mozversion platform_version: 52.0a1 07:19:27 INFO - using testdate: 1478096367 07:19:27 INFO - actual date: 1478096367 07:19:27 INFO - starting webserver on 'localhost:37142' 07:19:27 INFO - SUITE-START | Running 2 tests 07:19:27 INFO - TEST-START | dromaeo_css 07:19:27 INFO - operating with platform_type : linux_ 07:19:27 INFO - Initialising browser for dromaeo_css test... 07:19:27 INFO - TEST-INFO | started process 18912 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyEr3QG/profile http://localhost:37142/getInfo.html) 07:19:31 INFO - PROCESS | 18912 | __metrics Screen width/height:1600/1200 07:19:31 INFO - PROCESS | 18912 | colorDepth:24 07:19:31 INFO - PROCESS | 18912 | Browser inner width/height: 1024/697 07:19:31 INFO - PROCESS | 18912 | __metrics 07:19:32 INFO - PROCESS | 18912 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:19:32 INFO - PROCESS | 18912 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:19:32 INFO - PROCESS | 18912 | console.error: PushService: 07:19:32 INFO - PROCESS | 18912 | stateChangeProcessEnqueue: Error transitioning state 07:19:32 INFO - PROCESS | 18912 | UnknownError 07:19:33 INFO - TEST-INFO | 18912: exit 0 07:19:33 INFO - Browser initialized. 07:19:33 INFO - Running cycle 1/1 for dromaeo_css test... 07:19:33 INFO - TEST-INFO | started process 18993 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyEr3QG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:19:45 INFO - PROCESS | 18993 | RSS: Main: 172670976 07:19:45 INFO - PROCESS | 18993 | 07:20:36 INFO - PROCESS | 18993 | 1478096436880 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] 07:22:47 INFO - PROCESS | 18993 | Cycle 1(1): loaded http://localhost:37142/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37142/tests/dromaeo/cssquery-ext.html) 07:22:49 INFO - PROCESS | 18993 | RSS: Main: 320950272 07:22:49 INFO - PROCESS | 18993 | 07:25:51 INFO - PROCESS | 18993 | Cycle 1(1): loaded http://localhost:37142/tests/dromaeo/cssquery-ext.html (next: http://localhost:37142/tests/dromaeo/cssquery-jquery.html) 07:25:52 INFO - PROCESS | 18993 | RSS: Main: 280768512 07:25:52 INFO - PROCESS | 18993 | 07:28:54 INFO - PROCESS | 18993 | Cycle 1(1): loaded http://localhost:37142/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37142/tests/dromaeo/cssquery-mootools.html) 07:28:55 INFO - PROCESS | 18993 | RSS: Main: 215834624 07:28:55 INFO - PROCESS | 18993 | 07:31:57 INFO - PROCESS | 18993 | Cycle 1(1): loaded http://localhost:37142/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37142/tests/dromaeo/cssquery-prototype.html) 07:31:57 INFO - PROCESS | 18993 | RSS: Main: 255094784 07:31:57 INFO - PROCESS | 18993 | 07:35:00 INFO - PROCESS | 18993 | Cycle 1(1): loaded http://localhost:37142/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37142/tests/dromaeo/cssquery-yui.html) 07:35:01 INFO - PROCESS | 18993 | RSS: Main: 217481216 07:35:01 INFO - PROCESS | 18993 | 07:38:04 INFO - PROCESS | 18993 | Cycle 1(1): loaded http://localhost:37142/tests/dromaeo/cssquery-yui.html (next: http://localhost:37142/tests/dromaeo/cssquery-dojo.html) 07:38:04 INFO - PROCESS | 18993 | RSS: Main: 309866496 07:38:04 INFO - PROCESS | 18993 | 07:38:04 INFO - PROCESS | 18993 | __start_tp_report 07:38:04 INFO - PROCESS | 18993 | _x_x_mozilla_page_load 07:38:04 INFO - PROCESS | 18993 | _x_x_mozilla_page_load_details 07:38:04 INFO - PROCESS | 18993 | |i|pagename|runs| 07:38:04 INFO - PROCESS | 18993 | |0;dojo.html;3006.2183832203627;3021.09367189843;3050.1307127468663;3058.0061480018985;3066.892658756944;5256.08018596745;5327.413984461706;5351.09031464651;5366.731663416828;5415.593830462712;5341.172118321657;5353.464653534655;5360.9463905360935;5365.731713414333;5383.084875571152;4855.0047240315735;4901.730404827733;4918.434380046305;4945.159322915095;4963.950360496403;4874.147024270738;4899.755012249373;4914.1400254955415;4955.380577427822;5073.213651883964;4933.1120398328285;4949.059678661061;4952.826651067214;4954.529319714621;5013.473585273548;181.06119768997735;4923.113839508887;4931.506849315076;4946.208606622941;5000.72496012721;4824;4856.125897338477;4870.196417591093;4948.851534453972;4990.550850423443;5339.919901201485;5359.169328754049;5363.812266570691;5392.440494735654;5416.025115479212;5549.250851135085;5664.886702265972;5789;5793.8551536211935;5795.130730390433;5634.859128521779;5663.461971112738;5679.971600142014;5680.31836179657;5742;5348.705821179834;5353.2773075634295;5354;5355.036093503168;5357.973210133924;5813.505852002627;5822.359540450547;5825.446582574648;5827.35899051104;5828.737706803204;5399.892002160013;5447.264619276347;5450;5586.91619625706;5704.657720536781;5795.7971470999155;5796.565257605696;5799.797007104731;5849.034909239927;5872.94287028339;5773.624714393551;5778.8266352009505;5779.913301300484;5780.739866706008;5784.132380143013;5493.752781124859;5553.77784888608;5556.805511807148;5804.187413762077;5823.56323275756;4345.587169218919;4370.781460927004;4373.518912919576;4374.956250437455;4375.387445757597;3919.862804801818;3931.5282166139673;3943.369060950234;3958.9010274742786;3964.920701585952;5350.678959262456;5351.866203344947;5354.571634269249;5355.982363351029;5358.4373640767935;5602.887942241132;5635.492805647429;5648.632838865543;5649.802256920988;5653.660780353192;5395.703236321961;5422.539084177889;5424.511793938565;5426.294581704353;5427.48438898304;4959.181735013754;4960.925586116211;4961.801527938915;4973.726445045557;4980.9252861207115;6012.879742405127;6013.609115407485;6024.3072046714315;6024.518038556905;6027.849303767441;5557.527610153183;5803.970980145073;5809.099589563455;5809.331926828299;5811.27359080115;5879.676617786063;5948.167256583995;5963.2844058713235;5965.91051134242;6061.848453788691;5670.376258611467;5670.546356291405;5672.7730890763905;5726.4273572642405;5739.225204597493;5764.740586673526;5768.682722450306;5770.5095066919785;5771.278590176228;5772.278465191851;5402.324709411324;5439.836804895701;5511.751971161227;5632.971835140798;5635.830925072254;5608;5630;5662.886742265049;5737.168110623853;5750.856228594319;5660.349059858005;5661.547076233809;5663.122216056518;5666.291713535808;5714.371419143974;5643.238162848127;5643.32280126371;5683.232763576864;5693.8291851242875;5725.16985037159;5387.488188622075;5464.207689885024;5503.3395992481155;5511.22842802016;5577.330720313588 07:38:04 INFO - PROCESS | 18993 | |1;ext.html;552.4614841937392;600.147790138004;608.7869245763982;625.6652690810414;634.7714822663837;31171.376572468536;31678.524822127656;41828.372574411405;43145;43198;40636.18727625453;44101;44305.556944430544;44339;44361.556384436146;8747.081556436578;8915.465072095663;8939.195472407482;8941.284697224239;8946.284297256236;7984.361251099927;8168.714095006676;8170.591470426484;8805.911940880605;10436.582536698523;10472.738181545446;10886.673399797979;10895.182861285395;10895.455227238606;10896.564137434492;10732.624358147428;10819.621313254078;10836.674899752981;10859.945700271526;10867.891321086767;10751.784964300748;10815.297005694605;10816.945915270373;10819.242653014293;10822.134229261641;40483.59516404857;40730.185396291905;40740;40778.18443631111;40853.38719919204;3405;3523.0352303522945;3535.169235229719;3725.4225595032544;3906.0234941264684;31171;31631.84184079065;31692.366152676816;31955;32701.50947735786;4250.659947204216;4288.549702281247;4290.163418133465;4372.6064654180955;4411.595680354215;318164;320222;320291;320451;320621;50300.748496257285;50411.24383134256;50451.24323135156;50467.24299135516;50531.74734126379;35495;36161.27677446489;36191;51858.48141518612;52001.7399912998;15226.46707365237;15694.293756780744;15805.762913556306;15810.683786324209;15817;11634.069274458023;11660.53357865676;11667.124965627612;11667.824982625267;11668.76662466746;16479.423220187236;16983.49049528516;18243;18627.441176764718;18933.905330473535;6895.207051189077;6984.333225056785;7011.228764835864;7135.357817796319;7173.282671732785;922.2714055895767;1043.8016776812533;1050.3120456101267;1060.5757696921294;1065.1106326217696;31703.682963170075;31791.36417271688;32175.35649287048;32284;32323.838380808415;1114.648885601033;1171.77736230116;1180.4451907603413;1195.4202211927209;1209.5766481731323;16742.162891855358;16924.492265232064;16993.23530441133;17054.74417883733;17153.228104735317;482058;485079;485498;486375;486953;56318.71840640771;56721.43278567244;56757;57020;57030.71484642633;1206.8732783057653;1250.5623031938749;1274.1908887856277;1328.920264784116;1333.8932885369147;28137.43725125445;32472.67527324791;32513.187170320933;32880;33254.16864578405;48555.51444485651;49359;49466;49492.75253623853;49507.50492495029;371005;371648;372321;372377;372605;27148.1855544334;27594.724052759215;27887.860560697067;28054.719452806028;29218.26954326074;46145.76927115343;46163.30755038744;46275.305870412645;46778.76610616925;46900.29649555191;36725;37297.27027297357;38163;39134;39203.2159356817;38412.42381364338;38554.61445385622;39074.41388379233;39855.2028959425;40286.597134029456;35578.822105890344;37401.43897841589;37640.43539346857;37745;37820.24359512849;33594.49608255829;34925;35170.47244291389;35776.63350497446;35850.28299434049;25582.61626075573;25860.482790344464;25864.724411014013;25942.22173334803;26007.60988585135 07:38:04 INFO - PROCESS | 18993 | |2;jquery.html;366.5601278465842;368.29103974848425;381.79001549147966;384.47519136378844;395.12676983865657;14368.20974846383;16868;17762.467125986208;18714.812851871477;19066;17382.826171738277;17589.472315830546;18130.274789008425;18131.184096715646;18302.72545911809;5209.479052094798;5498.202760599711;5499.422560631137;5499.697516636584;5500.119980803072;3940.7886553053863;4005.239004589119;5380.569554435636;5471.343438787351;5472.644278121929;5710.172025056364;6625.9668701656665;6629.469642428594;6636.203655561315;6637.435817955479;6112.908306375408;6139.631622102644;6366.713497892606;6606.504512161583;6647.867042659144;5936.821895343103;5937.139114828326;5940.940590594082;5941.079132734433;5946.226990491208;14300.642483937881;14302.64243393913;14306.57080287593;14310.64223394413;14342;2355.740868504463;2357.6934998450265;2399.3281881073326;2409.3013026222375;2503.236512863576;10299.53652085658;10836.729081772939;10905.727356816064;13071.888889444313;13847.238401887893;1858.3681548273516;1953.7460130183126;1970.8423326133875;1987.0859404673868;1998.7801341852385;74366.25633743647;79585;80324.19675803225;82084.58957705174;82539;10517.52671129801;10938.945305273422;11395.777823324537;11401.828972565418;11487.368194749202;15517.45688900883;15533.223338833013;15560.299786509635;15562.377504899678;15562.377504899903;7757.146713861471;7952.642131104114;7983.481073730189;8135.7152499662225;8251.669933202726;7696.384289256846;7804.2585954334245;8015.238552337519;8054.637541310655;8135.877961830577;4747.905041899143;4804.567588917014;4823.1800593899125;4840.322354870321;4925.556699897026;1841.4128149949343;1855.7123645834918;1856.136896343207;1862.3574866670976;1900.5058684742066;724.4964749499153;871.812560299526;885.1369914333474;898.4474548152839;971.4608392342318;17170.141492925304;17190.828091719173;18280.54298642518;18665.626687466447;19015.809841901682;876.7150676030316;892.1658249536704;896.8027034052498;909.2271569166288;919.7240827751648;9271.165595096474;10144.746381340525;10514.158867290598;10661.39196469398;10694.037536621741;454488;457527;477299;477455;479169;53548;63109;88900.11099889048;92520.53739731258;92552;985.7387792235063;1006.1950439648252;1020.698893826323;1023.6673081248624;1024.71820249432;15634.140122293384;16820.411285604947;17187.3984410545;17778.822211777715;18145.818541814413;41748.79125604353;42905.35641965435;43186.35220471633;43544.56455435405;44158;57397.426025740875;57458.42541574531;57670.13494797665;57828;58882;7363.300486453778;7545.849083018199;7704.768856934301;7866.9213307866185;8125.390595705464;13109.016823738448;13285.535006274735;13394.330283485982;13534.526291579747;13593.52422665202;11397.430128493377;11663.708407289885;11726.589569365373;12059.879401205875;12128.211666241667;10524.894751052392;11508.654740357802;11787.469563869476;11839.112066594867;11889.524419023488;11629.08120160164;11704.590339338083;11755.588554400554;12228.266304021787;12599.307038112991;7857.096433909945;7921.128675845767;8104.27061564462;8124.309433697966;8193.95151212197;10634.627788027381;11625.6512304631;11718.472668730099;11784.70538236551;12236.877631223573 07:38:04 INFO - PROCESS | 18993 | |3;mootools.html;1201.5974648492754;1218.8293638890557;1278.2522224498668;1599.264338404334;1624.9512514624566;6893.138357705287;7145.57126572406;7992.320652744516;8557.144285571447;8560.315174786017;7968.641411136498;8295.83408331833;8302.626381812817;8525.658973641062;8531.530765807878;2302.9193978210724;2318.2349824557855;2330.9650355244685;2331.125827814561;2333.6266197408418;1968.6456437841182;2032.227753453693;2295.345826439465;2354.0113152475915;2360.055977608953;2206.6359050756605;2286.542691461706;2288.8054515366216;2307.7576854430213;2312.4681323295654;2241.3724157236;2246.7528571857083;2263.9207627733117;2287.9428014299774;2290.2900100968586;2258.7402448718444;2267.614505534063;2281.9201327953606;2355.8115350771895;2374.952500949971;8436.915630843674;8485.618147183392;8494.362922780816;8495.957520212422;8502.872456913152;5093.5415812576675;5236.947630523722;5239.083160446907;5241.868953276198;5246.134387826004;3384.13704505352;3395.371856206585;3425.743069269815;3444.534987776643;3492.039689085522;1067.9572817087308;1142.8400023996564;1142.879878251957;1160.7678464307173;1172.2416375436844;11609.709757256052;11666.416679166092;11672.824907626307;11741.119416043832;11752.941235293854;4024.63778259958;4328.11273688893;4433.357163211316;4450.265706158512;4467.218236808546;9168.954155229181;9181.081891810765;9185.77035574116;9188.40275382098;9195.218406435528;5103.974480127576;5107.33604631403;5108.974455127701;5110.207917772751;5111.386633603991;4660.440747110369;4698.976505117453;4769.689970151929;4778.784954677048;4781.737004464788;3559.750817442806;3623.3659109655705;3647.7993710345654;3680.7791532508136;3710.14666626672;1020.9030142136485;1073.1897417449775;1087.2226358153957;1087.6465148826662;1120.5349779841438;784.2236186175759;916.6929078758691;922.31748506105;933.4446004627235;936.0031566381782;5632.155176723442;5646.463585959327;5745.712714364265;5749.223854779551;5792.797252096157;900.7297810656777;915.2037727177266;915.7069737683877;928.6192661008954;933.6405483888616;3948.526176858738;4068.1253530491085;4068.384761505917;4138.13099249161;4184.456020717348;9801.852972205423;10293.897061029294;10300.845487317696;10307.072363487323;10308.639197628198;10205.642802501878;10207.336523125972;10222.131118854832;10235.078842904175;10252.436116013541;7753.883691744629;7935.166807485246;7942.364610831235;7946.364290856717;7946.443748937634;5572.693501857437;5603.971980140236;5769.913451298318;5798.6810725410505;5873.588848780544;9474.52627368615;9504.47725375111;9504.524773761423;9549.09283618055;9573.569189386355;9412.811743764949;9759.951200243953;9805.950970245103;9852.704418867446;9873.50632468388;7099.396551292992;7231.819204519929;7234.855302893808;7235.131784185932;7255.56466612005;7896.960515197387;8046.959765201371;8072.83854322922;8076.1923807621115;8087.83824323522;5333.413264592525;6853.451723862178;6926.861462770616;6975.9302406975285;7045.823854403476;7171.8565628688175;7192.31672991065;7278.636068196675;7332.5967071811565;7453.962730186315;6653.201615806134;6733.528652994243;6794.592324460548;6813.523053386215;6815.591064536144;4869.245266983481;4923.433805112458;4938.38270216223;5007.899842003067;5206.687598744087;4897.3878265216845;4982.377202849644;4986.276989836381;5039.72281524505;5174.741262936914 07:38:04 INFO - PROCESS | 18993 | |4;prototype.html;325.6515528384629;326.4026830899454;328.33675974531445;332.808635034855;335.98320083995793;5062.21535661972;5216.6869987800665;5238.5023422774875;5274.681329667583;5287.1540553511395;4970.900581988358;5102.285680004802;5129.717865517395;5151.536361727443;5188.221766734991;4148.149629325981;4163.666906647461;4167.541570427251;4175.874723758277;4178.415021896937;4025.6175663311938;4119.40268661044;4147.5645057269;4185.455890734215;4195.874123776276;4081.69387295954;4101.692373072016;4105.774182419966;4107.835686572534;4108.938365924499;4079.7552146870985;4084.9387259191135;4089.3865920111925;4090.6318431341174;4093.222287765345;3631.963680363215;3635.1093981974323;3642.3079614873354;3651.580068292154;3660.2313514162056;5002.82490112848;5034.798608055673;5035.54680078791;5041.899162016776;5086.567641750456;4660.743659098748;4662.417197850269;4667.509911459316;4673.392458980345;4676.275177347517;5432.239486471857;5445.292112025411;5446.754896029688;5448.782048718046;5481.451854814526;3804.334241507725;3909.5308562972627;3939.951225362824;3950.3481925482547;3988.6809055275507;5591.944080559224;5624.971875140598;5629.874025194978;5642.322921249435;5667.376588575212;4026.1343811080174;4036.647723012765;4046.3323551613653;4074.1851629674184;4095.8736347504673;4031.173609410064;4081.836726530965;4097.160082183145;4102.528209255974;4149.730267532601;4610.792514336863;4626.588890388397;4631.814727410933;4636.629069674418;4637.791299391535;5443.129099344165;5493.423190565013;5495.862603434866;5497.433231528995;5508.256385388001;1310.8885744711806;1313.39583791457;1394.1635018988525;1403.9789403158961;1417.305520295048;879.8416285068749;894.190757364586;901.6844104563481;903.7876099116834;915.9786837675944;4646.79089440976;4648.395708557866;4661.857844828039;4661.906761864811;4663.813447462131;4845.491223421561;4865;4870.1233777920315;4877;4896.363472748591;4643.3284017753585;4649.395578574764;4665.720056796603;4698.929516057262;4699.694519856198;2780.944381112407;2995;3005.609270794783;3014.668386477486;3015.32155265068;5832.737526811304;5837.708114594253;5851.882962340815;5876.6180198286975;5881.411858814085;5480.561555075585;5726.198332233407;5757.424257574293;5764.875849209364;5774.595778295563;5760.8271751847515;5770.307563092456;5795.8551036224435;5799.507041901401;5812.796552120655;5603.8318850432925;5628.268325117872;5637.5489960802215;5641.971790141023;5644.915326270027;5338.1049727346235;5559.416261292506;5564.666120032811;5593;5610.158476228598;5849.830033993133;5850.385709500441;5852.824415267549;5875.823725288248;5875.970620146872;3976.3240249158293;4063.8374465022252;4074.4720729726355;4075.42943987836;4078.5513593505284;5355.30381050461;5643.915341269966;5681.147827825859;5688.687122208318;5693.629914055573;5253.658512196848;5386.78797270611;5459.399466058651;5465.6447330923365;5477.397486276586;5413.240696773643;5417.674939503485;5448.945510545002;5456.48163424474;5473.8357849264585;5236;5406.83779486616;5429.837104886859;5443.455654434683;5454.672719636835;5460.91808622863;5478.507279188039;5489.752961116679;5508.338999319947;5517.779288828562;5383.40782513931;5400.270963419888;5418.241446197457;5437.564994800486;5451.945480545302 07:38:04 INFO - PROCESS | 18993 | |5;yui.html;686.7596341280553;700.5376451541983;750.9586972716498;762.2872614105811;790.9564973926435;13127.671808204788;13784.241866697354;13815.03294769364;14011.439542418304;14068.507602233936;12857.678558036054;13053.804192937114;13062.346882655876;13078.215307081582;13085;649.7011374767612;660.8447014951482;762.5653377574785;776.0454640791829;798.9041315042203;802.5866678660494;805.1425232127795;805.3959530352236;805.3999770171231;805.7582725182451;840.8570543007672;844.3835999720208;844.8817165596821;845.0366582096415;845.3406343052429;667.706209267923;690.5752961928428;692.7402224165937;693.448708276921;843.4180415513307;593;612.2713970375239;617.200725061047;617.4844005255617;617.6355949989482;13496;13555.86444135556;13597.252151131685;13615.727685446236;13627.863721362759;12919.806202906964;12942.741145177139;13016.609501714964;13076.346182690922;13104.80342794859;11236.943815280953;11262.859698822174;11309.377984210865;11544.480498377508;11562.132840036948;4172.5410204877435;4187.602177793105;4233.174530966463;4395.912081758379;4440.977795111036;53118.20322695163;58638.70680646569;59584.10623840646;60900;61513.38486615122;10199.439030853375;10675.679729608124;10848.240623156304;10909.236353455182;11050.557977680803;19452.513687157934;19481;19486.610267794564;19486.902565487082;19498.31755888537;7747.341475974606;7850.371970242481;7944.960275198587;8415.873761893576;8439.873401898976;4448.332750087513;4493.483249426293;4531.229690952546;4610.147122782296;4665.766711664403;3408.863645454204;3519.9472007919903;3527.8588856445967;3528.1003344147593;3534.3108093921437;550.7906995341745;552.6573524414888;559.2254727202853;572.5362456410321;576.2681394628798;645.9289478157399;659.9670016499156;680.43863812355;686.8660611180771;734.7428400060043;9201.861972070425;9272.72181834546;9292.210162136294;9344.205742511962;9345.205657519187;610.7526451787033;656.8916128838783;662.7183447035087;692.9930700693029;716.9749058782918;4384.364267181241;4681.250999840009;4763.428388593391;4769.689970151999;4844.176489996638;86091;89213.94149053232;89682.10317896737;90922;91931;61718;64535.354646452935;79434.6028269855;80406;80613.59693201496;40327.3950890731;41696.79151604223;60956.695216523636;65545.34454655487;67294.32705672881;8233.46482478661;8729.432586882087;8862;9134.725958221265;9293.86059209126;42822.35766463443;42938;42980.78509607557;43434;44689.55310446854;36196.27607447889;36543.81728091343;39139.608603914734;56897;57007.71496142493;11537.711557211136;11631.418429078682;12059.75880482403;12156.878431215575;12424.440900159696;13399;13495.39270732839;13589.52436664712;13967.231802250973;14037.368318425491;12771.680707982376;13026.413811378321;13398.196108233537;13707.725845482835;13876.655263327564;12641.810372844231;12931.676708082374;12996.74332181151;13472.326383680973;13505.932470337586;12423.689407764878;12435.547467394343;12714.745705085661;13098.672533186747;13166.144200627312;9926;10677.822105854331;11082.501287441923;11083.501242443948;11504.482298296429;10059.346142500714;11344.289341993568;11391.259568128045;11416.372099534274;11553.653390398302 07:38:04 INFO - PROCESS | 18993 | __end_tp_report 07:38:04 INFO - PROCESS | 18993 | __start_cc_report 07:38:04 INFO - PROCESS | 18993 | _x_x_mozilla_cycle_collect,1369 07:38:04 INFO - PROCESS | 18993 | __end_cc_report 07:38:04 INFO - PROCESS | 18993 | __startTimestamp1478097484422__endTimestamp 07:38:04 INFO - PROCESS | 18993 | 07:38:04 INFO - PROCESS | 18993 | ------- Summary: start ------- 07:38:04 INFO - PROCESS | 18993 | Number of tests: 6 07:38:04 INFO - PROCESS | 18993 | 07:38:04 INFO - PROCESS | 18993 | [#0] dojo.html Cycles:165 Average:5306.58 Median:5493.75 stddev:727.77 (13.2%) stddev-sans-first:707.27 07:38:04 INFO - PROCESS | 18993 | Values: 3006.2 3021.1 3050.1 3058.0 3066.9 5256.1 5327.4 5351.1 5366.7 5415.6 5341.2 5353.5 5360.9 5365.7 5383.1 4855.0 4901.7 4918.4 4945.2 4964.0 4874.1 4899.8 4914.1 4955.4 5073.2 4933.1 4949.1 4952.8 4954.5 5013.5 181.1 4923.1 4931.5 4946.2 5000.7 4824.0 4856.1 4870.2 4948.9 4990.6 5339.9 5359.2 5363.8 5392.4 5416.0 5549.3 5664.9 5789.0 5793.9 5795.1 5634.9 5663.5 5680.0 5680.3 5742.0 5348.7 5353.3 5354.0 5355.0 5358.0 5813.5 5822.4 5825.4 5827.4 5828.7 5399.9 5447.3 5450.0 5586.9 5704.7 5795.8 5796.6 5799.8 5849.0 5872.9 5773.6 5778.8 5779.9 5780.7 5784.1 5493.8 5553.8 5556.8 5804.2 5823.6 4345.6 4370.8 4373.5 4375.0 4375.4 3919.9 3931.5 3943.4 3958.9 3964.9 5350.7 5351.9 5354.6 5356.0 5358.4 5602.9 5635.5 5648.6 5649.8 5653.7 5395.7 5422.5 5424.5 5426.3 5427.5 4959.2 4960.9 4961.8 4973.7 4980.9 6012.9 6013.6 6024.3 6024.5 6027.8 5557.5 5804.0 5809.1 5809.3 5811.3 5879.7 5948.2 5963.3 5965.9 6061.8 5670.4 5670.5 5672.8 5726.4 5739.2 5764.7 5768.7 5770.5 5771.3 5772.3 5402.3 5439.8 5511.8 5633.0 5635.8 5608.0 5630.0 5662.9 5737.2 5750.9 5660.3 5661.5 5663.1 5666.3 5714.4 5643.2 5643.3 5683.2 5693.8 5725.2 5387.5 5464.2 5503.3 5511.2 5577.3 07:38:04 INFO - PROCESS | 18993 | 07:38:04 INFO - PROCESS | 18993 | [#1] ext.html Cycles:180 Average:54871.15 Median:35813.46 stddev:105270.02 (293.9%) stddev-sans-first:105486.33 07:38:04 INFO - PROCESS | 18993 | Values: 552.5 600.1 608.8 625.7 634.8 31171.4 31678.5 41828.4 43145.0 43198.0 40636.2 44101.0 44305.6 44339.0 44361.6 8747.1 8915.5 8939.2 8941.3 8946.3 7984.4 8168.7 8170.6 8805.9 10436.6 10472.7 10886.7 10895.2 10895.5 10896.6 10732.6 10819.6 10836.7 10859.9 10867.9 10751.8 10815.3 10816.9 10819.2 10822.1 40483.6 40730.2 40740.0 40778.2 40853.4 3405.0 3523.0 3535.2 3725.4 3906.0 31171.0 31631.8 31692.4 31955.0 32701.5 4250.7 4288.5 4290.2 4372.6 4411.6 318164.0 320222.0 320291.0 320451.0 320621.0 50300.7 50411.2 50451.2 50467.2 50531.7 35495.0 36161.3 36191.0 51858.5 52001.7 15226.5 15694.3 15805.8 15810.7 15817.0 11634.1 11660.5 11667.1 11667.8 11668.8 16479.4 16983.5 18243.0 18627.4 18933.9 6895.2 6984.3 7011.2 7135.4 7173.3 922.3 1043.8 1050.3 1060.6 1065.1 31703.7 31791.4 32175.4 32284.0 32323.8 1114.6 1171.8 1180.4 1195.4 1209.6 16742.2 16924.5 16993.2 17054.7 17153.2 482058.0 485079.0 485498.0 486375.0 486953.0 56318.7 56721.4 56757.0 57020.0 57030.7 1206.9 1250.6 1274.2 1328.9 1333.9 28137.4 32472.7 32513.2 32880.0 33254.2 48555.5 49359.0 49466.0 49492.8 49507.5 371005.0 371648.0 372321.0 372377.0 372605.0 27148.2 27594.7 27887.9 28054.7 29218.3 46145.8 46163.3 46275.3 46778.8 46900.3 36725.0 37297.3 38163.0 39134.0 39203.2 38412.4 38554.6 39074.4 39855.2 40286.6 35578.8 37401.4 37640.4 37745.0 37820.2 33594.5 34925.0 35170.5 35776.6 35850.3 25582.6 25860.5 25864.7 25942.2 26007.6 07:38:04 INFO - PROCESS | 18993 | 07:38:04 INFO - PROCESS | 18993 | [#2] jquery.html Cycles:180 Average:27689.10 Median:383.13 stddev:77290.53 (20173.3%) stddev-sans-first:77480.13 07:38:04 INFO - PROCESS | 18993 | Values: 366.6 368.3 381.8 384.5 395.1 14368.2 16868.0 17762.5 18714.8 19066.0 17382.8 17589.5 18130.3 18131.2 18302.7 5209.5 5498.2 5499.4 5499.7 5500.1 3940.8 4005.2 5380.6 5471.3 5472.6 5710.2 6626.0 6629.5 6636.2 6637.4 6112.9 6139.6 6366.7 6606.5 6647.9 5936.8 5937.1 5940.9 5941.1 5946.2 14300.6 14302.6 14306.6 14310.6 14342.0 2355.7 2357.7 2399.3 2409.3 2503.2 10299.5 10836.7 10905.7 13071.9 13847.2 1858.4 1953.7 1970.8 1987.1 1998.8 74366.3 79585.0 80324.2 82084.6 82539.0 10517.5 10938.9 11395.8 11401.8 11487.4 15517.5 15533.2 15560.3 15562.4 15562.4 7757.1 7952.6 7983.5 8135.7 8251.7 7696.4 7804.3 8015.2 8054.6 8135.9 4747.9 4804.6 4823.2 4840.3 4925.6 1841.4 1855.7 1856.1 1862.4 1900.5 724.5 871.8 885.1 898.4 971.5 17170.1 17190.8 18280.5 18665.6 19015.8 876.7 892.2 896.8 909.2 919.7 9271.2 10144.7 10514.2 10661.4 10694.0 454488.0 457527.0 477299.0 477455.0 479169.0 53548.0 63109.0 88900.1 92520.5 92552.0 985.7 1006.2 1020.7 1023.7 1024.7 15634.1 16820.4 17187.4 17778.8 18145.8 41748.8 42905.4 43186.4 43544.6 44158.0 57397.4 57458.4 57670.1 57828.0 58882.0 7363.3 7545.8 7704.8 7866.9 8125.4 13109.0 13285.5 13394.3 13534.5 13593.5 11397.4 11663.7 11726.6 12059.9 12128.2 10524.9 11508.7 11787.5 11839.1 11889.5 11629.1 11704.6 11755.6 12228.3 12599.3 7857.1 7921.1 8104.3 8124.3 8194.0 10634.6 11625.7 11718.5 11784.7 12236.9 07:38:04 INFO - PROCESS | 18993 | 07:38:04 INFO - PROCESS | 18993 | [#3] mootools.html Cycles:180 Average:5494.97 Median:5109.59 stddev:3069.67 (60.1%) stddev-sans-first:3061.32 07:38:04 INFO - PROCESS | 18993 | Values: 1201.6 1218.8 1278.3 1599.3 1625.0 6893.1 7145.6 7992.3 8557.1 8560.3 7968.6 8295.8 8302.6 8525.7 8531.5 2302.9 2318.2 2331.0 2331.1 2333.6 1968.6 2032.2 2295.3 2354.0 2360.1 2206.6 2286.5 2288.8 2307.8 2312.5 2241.4 2246.8 2263.9 2287.9 2290.3 2258.7 2267.6 2281.9 2355.8 2375.0 8436.9 8485.6 8494.4 8496.0 8502.9 5093.5 5236.9 5239.1 5241.9 5246.1 3384.1 3395.4 3425.7 3444.5 3492.0 1068.0 1142.8 1142.9 1160.8 1172.2 11609.7 11666.4 11672.8 11741.1 11752.9 4024.6 4328.1 4433.4 4450.3 4467.2 9169.0 9181.1 9185.8 9188.4 9195.2 5104.0 5107.3 5109.0 5110.2 5111.4 4660.4 4699.0 4769.7 4778.8 4781.7 3559.8 3623.4 3647.8 3680.8 3710.1 1020.9 1073.2 1087.2 1087.6 1120.5 784.2 916.7 922.3 933.4 936.0 5632.2 5646.5 5745.7 5749.2 5792.8 900.7 915.2 915.7 928.6 933.6 3948.5 4068.1 4068.4 4138.1 4184.5 9801.9 10293.9 10300.8 10307.1 10308.6 10205.6 10207.3 10222.1 10235.1 10252.4 7753.9 7935.2 7942.4 7946.4 7946.4 5572.7 5604.0 5769.9 5798.7 5873.6 9474.5 9504.5 9504.5 9549.1 9573.6 9412.8 9760.0 9806.0 9852.7 9873.5 7099.4 7231.8 7234.9 7235.1 7255.6 7897.0 8047.0 8072.8 8076.2 8087.8 5333.4 6853.5 6926.9 6975.9 7045.8 7171.9 7192.3 7278.6 7332.6 7454.0 6653.2 6733.5 6794.6 6813.5 6815.6 4869.2 4923.4 4938.4 5007.9 5206.7 4897.4 4982.4 4986.3 5039.7 5174.7 07:38:04 INFO - PROCESS | 18993 | 07:38:04 INFO - PROCESS | 18993 | [#4] prototype.html Cycles:180 Average:4566.14 Median:5074.39 stddev:1336.61 (26.3%) stddev-sans-first:1301.91 07:38:04 INFO - PROCESS | 18993 | Values: 325.7 326.4 328.3 332.8 336.0 5062.2 5216.7 5238.5 5274.7 5287.2 4970.9 5102.3 5129.7 5151.5 5188.2 4148.1 4163.7 4167.5 4175.9 4178.4 4025.6 4119.4 4147.6 4185.5 4195.9 4081.7 4101.7 4105.8 4107.8 4108.9 4079.8 4084.9 4089.4 4090.6 4093.2 3632.0 3635.1 3642.3 3651.6 3660.2 5002.8 5034.8 5035.5 5041.9 5086.6 4660.7 4662.4 4667.5 4673.4 4676.3 5432.2 5445.3 5446.8 5448.8 5481.5 3804.3 3909.5 3940.0 3950.3 3988.7 5591.9 5625.0 5629.9 5642.3 5667.4 4026.1 4036.6 4046.3 4074.2 4095.9 4031.2 4081.8 4097.2 4102.5 4149.7 4610.8 4626.6 4631.8 4636.6 4637.8 5443.1 5493.4 5495.9 5497.4 5508.3 1310.9 1313.4 1394.2 1404.0 1417.3 879.8 894.2 901.7 903.8 916.0 4646.8 4648.4 4661.9 4661.9 4663.8 4845.5 4865.0 4870.1 4877.0 4896.4 4643.3 4649.4 4665.7 4698.9 4699.7 2780.9 2995.0 3005.6 3014.7 3015.3 5832.7 5837.7 5851.9 5876.6 5881.4 5480.6 5726.2 5757.4 5764.9 5774.6 5760.8 5770.3 5795.9 5799.5 5812.8 5603.8 5628.3 5637.5 5642.0 5644.9 5338.1 5559.4 5564.7 5593.0 5610.2 5849.8 5850.4 5852.8 5875.8 5876.0 3976.3 4063.8 4074.5 4075.4 4078.6 5355.3 5643.9 5681.1 5688.7 5693.6 5253.7 5386.8 5459.4 5465.6 5477.4 5413.2 5417.7 5448.9 5456.5 5473.8 5236.0 5406.8 5429.8 5443.5 5454.7 5460.9 5478.5 5489.8 5508.3 5517.8 5383.4 5400.3 5418.2 5437.6 5451.9 07:38:04 INFO - PROCESS | 18993 | 07:38:04 INFO - PROCESS | 18993 | [#5] yui.html Cycles:180 Average:16578.99 Median:24591.52 stddev:21772.00 (88.5%) stddev-sans-first:21800.37 07:38:04 INFO - PROCESS | 18993 | Values: 686.8 700.5 751.0 762.3 791.0 13127.7 13784.2 13815.0 14011.4 14068.5 12857.7 13053.8 13062.3 13078.2 13085.0 649.7 660.8 762.6 776.0 798.9 802.6 805.1 805.4 805.4 805.8 840.9 844.4 844.9 845.0 845.3 667.7 690.6 692.7 693.4 843.4 593.0 612.3 617.2 617.5 617.6 13496.0 13555.9 13597.3 13615.7 13627.9 12919.8 12942.7 13016.6 13076.3 13104.8 11236.9 11262.9 11309.4 11544.5 11562.1 4172.5 4187.6 4233.2 4395.9 4441.0 53118.2 58638.7 59584.1 60900.0 61513.4 10199.4 10675.7 10848.2 10909.2 11050.6 19452.5 19481.0 19486.6 19486.9 19498.3 7747.3 7850.4 7945.0 8415.9 8439.9 4448.3 4493.5 4531.2 4610.1 4665.8 3408.9 3519.9 3527.9 3528.1 3534.3 550.8 552.7 559.2 572.5 576.3 645.9 660.0 680.4 686.9 734.7 9201.9 9272.7 9292.2 9344.2 9345.2 610.8 656.9 662.7 693.0 717.0 4384.4 4681.3 4763.4 4769.7 4844.2 86091.0 89213.9 89682.1 90922.0 91931.0 61718.0 64535.4 79434.6 80406.0 80613.6 40327.4 41696.8 60956.7 65545.3 67294.3 8233.5 8729.4 8862.0 9134.7 9293.9 42822.4 42938.0 42980.8 43434.0 44689.6 36196.3 36543.8 39139.6 56897.0 57007.7 11537.7 11631.4 12059.8 12156.9 12424.4 13399.0 13495.4 13589.5 13967.2 14037.4 12771.7 13026.4 13398.2 13707.7 13876.7 12641.8 12931.7 12996.7 13472.3 13505.9 12423.7 12435.5 12714.7 13098.7 13166.1 9926.0 10677.8 11082.5 11083.5 11504.5 10059.3 11344.3 11391.3 11416.4 11553.7 07:38:04 INFO - PROCESS | 18993 | -------- Summary: end -------- 07:38:04 INFO - PROCESS | 18993 | 07:38:05 INFO - TEST-INFO | 18993: exit 0 07:38:05 INFO - TEST-OK | dromaeo_css | took 1118197ms 07:38:05 INFO - TEST-START | kraken 07:38:05 INFO - operating with platform_type : linux_ 07:38:05 INFO - Initialising browser for kraken test... 07:38:05 INFO - TEST-INFO | started process 19336 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfzn6Bk/profile http://localhost:37142/getInfo.html) 07:38:09 INFO - PROCESS | 19336 | __metrics Screen width/height:1600/1200 07:38:09 INFO - PROCESS | 19336 | colorDepth:24 07:38:09 INFO - PROCESS | 19336 | Browser inner width/height: 1024/697 07:38:09 INFO - PROCESS | 19336 | __metrics 07:38:10 INFO - PROCESS | 19336 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:38:10 INFO - PROCESS | 19336 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:38:10 INFO - PROCESS | 19336 | console.error: PushService: 07:38:10 INFO - PROCESS | 19336 | stateChangeProcessEnqueue: Error transitioning state 07:38:10 INFO - PROCESS | 19336 | UnknownError 07:38:11 INFO - TEST-INFO | 19336: exit 0 07:38:11 INFO - Browser initialized. 07:38:11 INFO - Running cycle 1/1 for kraken test... 07:38:11 INFO - TEST-INFO | started process 19422 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfzn6Bk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:38:23 INFO - PROCESS | 19422 | RSS: Main: 172646400 07:38:23 INFO - PROCESS | 19422 | 07:38:26 INFO - PROCESS | 19422 | Cycle 1(1): loaded http://localhost:37142/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37142/tests/kraken/driver.html?testName=audio-beat-detection) 07:38:27 INFO - PROCESS | 19422 | RSS: Main: 229052416 07:38:27 INFO - PROCESS | 19422 | 07:38:29 INFO - PROCESS | 19422 | Cycle 1(1): loaded http://localhost:37142/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37142/tests/kraken/driver.html?testName=audio-dft) 07:38:30 INFO - PROCESS | 19422 | RSS: Main: 215707648 07:38:30 INFO - PROCESS | 19422 | 07:38:33 INFO - PROCESS | 19422 | Cycle 1(1): loaded http://localhost:37142/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37142/tests/kraken/driver.html?testName=audio-fft) 07:38:33 INFO - PROCESS | 19422 | RSS: Main: 297775104 07:38:33 INFO - PROCESS | 19422 | 07:38:36 INFO - PROCESS | 19422 | Cycle 1(1): loaded http://localhost:37142/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37142/tests/kraken/driver.html?testName=audio-oscillator) 07:38:36 INFO - PROCESS | 19422 | RSS: Main: 206917632 07:38:36 INFO - PROCESS | 19422 | 07:38:38 INFO - PROCESS | 19422 | Cycle 1(1): loaded http://localhost:37142/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37142/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:38:39 INFO - PROCESS | 19422 | RSS: Main: 211984384 07:38:39 INFO - PROCESS | 19422 | 07:38:42 INFO - PROCESS | 19422 | Cycle 1(1): loaded http://localhost:37142/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37142/tests/kraken/driver.html?testName=imaging-darkroom) 07:38:42 INFO - PROCESS | 19422 | RSS: Main: 248328192 07:38:42 INFO - PROCESS | 19422 | 07:38:46 INFO - PROCESS | 19422 | Cycle 1(1): loaded http://localhost:37142/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37142/tests/kraken/driver.html?testName=imaging-desaturate) 07:38:46 INFO - PROCESS | 19422 | RSS: Main: 246833152 07:38:46 INFO - PROCESS | 19422 | 07:38:49 INFO - PROCESS | 19422 | Cycle 1(1): loaded http://localhost:37142/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37142/tests/kraken/driver.html?testName=json-parse-financial) 07:38:50 INFO - PROCESS | 19422 | RSS: Main: 246616064 07:38:50 INFO - PROCESS | 19422 | 07:38:51 INFO - PROCESS | 19422 | Cycle 1(1): loaded http://localhost:37142/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37142/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:38:52 INFO - PROCESS | 19422 | RSS: Main: 208744448 07:38:52 INFO - PROCESS | 19422 | 07:38:53 INFO - PROCESS | 19422 | Cycle 1(1): loaded http://localhost:37142/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37142/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:38:54 INFO - PROCESS | 19422 | RSS: Main: 215789568 07:38:54 INFO - PROCESS | 19422 | 07:38:56 INFO - PROCESS | 19422 | Cycle 1(1): loaded http://localhost:37142/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37142/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:38:57 INFO - PROCESS | 19422 | RSS: Main: 225792000 07:38:57 INFO - PROCESS | 19422 | 07:38:59 INFO - PROCESS | 19422 | Cycle 1(1): loaded http://localhost:37142/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37142/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:39:00 INFO - PROCESS | 19422 | RSS: Main: 234455040 07:39:00 INFO - PROCESS | 19422 | 07:39:03 INFO - PROCESS | 19422 | Cycle 1(1): loaded http://localhost:37142/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37142/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:39:03 INFO - PROCESS | 19422 | RSS: Main: 231161856 07:39:03 INFO - PROCESS | 19422 | 07:39:05 INFO - PROCESS | 19422 | Cycle 1(1): loaded http://localhost:37142/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37142/tests/kraken/driver.html?testName=ai-astar) 07:39:05 INFO - PROCESS | 19422 | RSS: Main: 281096192 07:39:05 INFO - PROCESS | 19422 | 07:39:05 INFO - PROCESS | 19422 | __start_tp_report 07:39:05 INFO - PROCESS | 19422 | _x_x_mozilla_page_load 07:39:05 INFO - PROCESS | 19422 | _x_x_mozilla_page_load_details 07:39:05 INFO - PROCESS | 19422 | |i|pagename|runs| 07:39:05 INFO - PROCESS | 19422 | |0;ai-astar;104;113;112;113;112;115;112;113;115;112 07:39:05 INFO - PROCESS | 19422 | |1;audio-beat-detection;148;125;121;164;125;129;124;122;155;124 07:39:05 INFO - PROCESS | 19422 | |2;audio-dft;160;161;163;161;162;163;162;161;161;161 07:39:05 INFO - PROCESS | 19422 | |3;audio-fft;74;75;75;100;76;75;77;77;100;77 07:39:05 INFO - PROCESS | 19422 | |4;audio-oscillator;83;83;114;83;84;83;106;83;83;115 07:39:05 INFO - PROCESS | 19422 | |5;imaging-gaussian-blur;118;118;118;118;118;116;118;117;120;118 07:39:05 INFO - PROCESS | 19422 | |6;imaging-darkroom;146;145;146;145;146;146;146;146;146;145 07:39:05 INFO - PROCESS | 19422 | |7;imaging-desaturate;85;85;84;85;84;85;84;84;84;85 07:39:05 INFO - PROCESS | 19422 | |8;json-parse-financial;53;52;51;52;51;53;52;53;53;54 07:39:05 INFO - PROCESS | 19422 | |9;json-stringify-tinderbox;59;60;59;60;60;60;61;60;60;60 07:39:05 INFO - PROCESS | 19422 | |10;stanford-crypto-aes;80;81;84;79;80;79;81;79;80;78 07:39:05 INFO - PROCESS | 19422 | |11;stanford-crypto-ccm;146;133;130;132;133;129;133;143;178;149 07:39:05 INFO - PROCESS | 19422 | |12;stanford-crypto-pbkdf2;168;168;166;167;165;169;170;172;164;164 07:39:05 INFO - PROCESS | 19422 | |13;stanford-crypto-sha256-iterative;65;65;65;73;65;65;66;65;66;63 07:39:05 INFO - PROCESS | 19422 | __end_tp_report 07:39:05 INFO - PROCESS | 19422 | __start_cc_report 07:39:05 INFO - PROCESS | 19422 | _x_x_mozilla_cycle_collect,1682 07:39:05 INFO - PROCESS | 19422 | __end_cc_report 07:39:05 INFO - PROCESS | 19422 | __startTimestamp1478097545858__endTimestamp 07:39:05 INFO - PROCESS | 19422 | 07:39:05 INFO - PROCESS | 19422 | ------- Summary: start ------- 07:39:05 INFO - PROCESS | 19422 | Number of tests: 14 07:39:05 INFO - PROCESS | 19422 | 07:39:05 INFO - PROCESS | 19422 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.00 stddev:3.07 (2.7%) stddev-sans-first:1.22 07:39:05 INFO - PROCESS | 19422 | Values: 104.0 113.0 112.0 113.0 112.0 115.0 112.0 113.0 115.0 112.0 07:39:05 INFO - PROCESS | 19422 | 07:39:05 INFO - PROCESS | 19422 | [#1] audio-beat-detection Cycles:10 Average:133.70 Median:127.00 stddev:15.76 (12.4%) stddev-sans-first:15.85 07:39:05 INFO - PROCESS | 19422 | Values: 148.0 125.0 121.0 164.0 125.0 129.0 124.0 122.0 155.0 124.0 07:39:05 INFO - PROCESS | 19422 | 07:39:05 INFO - PROCESS | 19422 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:0.97 (0.6%) stddev-sans-first:0.87 07:39:05 INFO - PROCESS | 19422 | Values: 160.0 161.0 163.0 161.0 162.0 163.0 162.0 161.0 161.0 161.0 07:39:05 INFO - PROCESS | 19422 | 07:39:05 INFO - PROCESS | 19422 | [#3] audio-fft Cycles:10 Average:80.60 Median:75.50 stddev:10.28 (13.6%) stddev-sans-first:10.62 07:39:05 INFO - PROCESS | 19422 | Values: 74.0 75.0 75.0 100.0 76.0 75.0 77.0 77.0 100.0 77.0 07:39:05 INFO - PROCESS | 19422 | 07:39:05 INFO - PROCESS | 19422 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:83.00 stddev:13.98 (16.8%) stddev-sans-first:14.47 07:39:05 INFO - PROCESS | 19422 | Values: 83.0 83.0 114.0 83.0 84.0 83.0 106.0 83.0 83.0 115.0 07:39:05 INFO - PROCESS | 19422 | 07:39:05 INFO - PROCESS | 19422 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.99 (0.8%) stddev-sans-first:1.05 07:39:05 INFO - PROCESS | 19422 | Values: 118.0 118.0 118.0 118.0 118.0 116.0 118.0 117.0 120.0 118.0 07:39:05 INFO - PROCESS | 19422 | 07:39:05 INFO - PROCESS | 19422 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 07:39:05 INFO - PROCESS | 19422 | Values: 146.0 145.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 145.0 07:39:05 INFO - PROCESS | 19422 | 07:39:05 INFO - PROCESS | 19422 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:85.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 07:39:05 INFO - PROCESS | 19422 | Values: 85.0 85.0 84.0 85.0 84.0 85.0 84.0 84.0 84.0 85.0 07:39:05 INFO - PROCESS | 19422 | 07:39:05 INFO - PROCESS | 19422 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:53.00 stddev:0.97 (1.8%) stddev-sans-first:1.00 07:39:05 INFO - PROCESS | 19422 | Values: 53.0 52.0 51.0 52.0 51.0 53.0 52.0 53.0 53.0 54.0 07:39:05 INFO - PROCESS | 19422 | 07:39:05 INFO - PROCESS | 19422 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 07:39:05 INFO - PROCESS | 19422 | Values: 59.0 60.0 59.0 60.0 60.0 60.0 61.0 60.0 60.0 60.0 07:39:05 INFO - PROCESS | 19422 | 07:39:05 INFO - PROCESS | 19422 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:80.00 stddev:1.66 (2.1%) stddev-sans-first:1.76 07:39:05 INFO - PROCESS | 19422 | Values: 80.0 81.0 84.0 79.0 80.0 79.0 81.0 79.0 80.0 78.0 07:39:05 INFO - PROCESS | 19422 | 07:39:05 INFO - PROCESS | 19422 | [#11] stanford-crypto-ccm Cycles:10 Average:140.60 Median:138.00 stddev:14.90 (10.8%) stddev-sans-first:15.68 07:39:05 INFO - PROCESS | 19422 | Values: 146.0 133.0 130.0 132.0 133.0 129.0 133.0 143.0 178.0 149.0 07:39:05 INFO - PROCESS | 19422 | 07:39:05 INFO - PROCESS | 19422 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.30 Median:168.00 stddev:2.63 (1.6%) stddev-sans-first:2.77 07:39:05 INFO - PROCESS | 19422 | Values: 168.0 168.0 166.0 167.0 165.0 169.0 170.0 172.0 164.0 164.0 07:39:05 INFO - PROCESS | 19422 | 07:39:05 INFO - PROCESS | 19422 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:65.00 stddev:2.66 (4.1%) stddev-sans-first:2.80 07:39:05 INFO - PROCESS | 19422 | Values: 65.0 65.0 65.0 73.0 65.0 65.0 66.0 65.0 66.0 63.0 07:39:05 INFO - PROCESS | 19422 | -------- Summary: end -------- 07:39:05 INFO - PROCESS | 19422 | 07:39:07 INFO - TEST-INFO | 19422: exit 0 07:39:07 INFO - TEST-OK | kraken | took 61762ms 07:39:07 INFO - SUITE-END | took 1179s 07:39:07 INFO - Completed test suite (00:19:40) 07:39:07 INFO - javascript benchmark 07:39:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3006.2183832203627, 3021.09367189843, 3050.1307127468663, 3058.0061480018985, 3066.892658756944, 5256.08018596745, 5327.413984461706, 5351.09031464651, 5366.731663416828, 5415.593830462712, 5341.172118321657, 5353.464653534655, 5360.9463905360935, 5365.731713414333, 5383.084875571152, 4855.0047240315735, 4901.730404827733, 4918.434380046305, 4945.159322915095, 4963.950360496403, 4874.147024270738, 4899.755012249373, 4914.1400254955415, 4955.380577427822, 5073.213651883964, 4933.1120398328285, 4949.059678661061, 4952.826651067214, 4954.529319714621, 5013.473585273548, 181.06119768997735, 4923.113839508887, 4931.506849315076, 4946.208606622941, 5000.72496012721, 4824.0, 4856.125897338477, 4870.196417591093, 4948.851534453972, 4990.550850423443, 5339.919901201485, 5359.169328754049, 5363.812266570691, 5392.440494735654, 5416.025115479212, 5549.250851135085, 5664.886702265972, 5789.0, 5793.8551536211935, 5795.130730390433, 5634.859128521779, 5663.461971112738, 5679.971600142014, 5680.31836179657, 5742.0, 5348.705821179834, 5353.2773075634295, 5354.0, 5355.036093503168, 5357.973210133924, 5813.505852002627, 5822.359540450547, 5825.446582574648, 5827.35899051104, 5828.737706803204, 5399.892002160013, 5447.264619276347, 5450.0, 5586.91619625706, 5704.657720536781, 5795.7971470999155, 5796.565257605696, 5799.797007104731, 5849.034909239927, 5872.94287028339, 5773.624714393551, 5778.8266352009505, 5779.913301300484, 5780.739866706008, 5784.132380143013, 5493.752781124859, 5553.77784888608, 5556.805511807148, 5804.187413762077, 5823.56323275756, 4345.587169218919, 4370.781460927004, 4373.518912919576, 4374.956250437455, 4375.387445757597, 3919.862804801818, 3931.5282166139673, 3943.369060950234, 3958.9010274742786, 3964.920701585952, 5350.678959262456, 5351.866203344947, 5354.571634269249, 5355.982363351029, 5358.4373640767935, 5602.887942241132, 5635.492805647429, 5648.632838865543, 5649.802256920988, 5653.660780353192, 5395.703236321961, 5422.539084177889, 5424.511793938565, 5426.294581704353, 5427.48438898304, 4959.181735013754, 4960.925586116211, 4961.801527938915, 4973.726445045557, 4980.9252861207115, 6012.879742405127, 6013.609115407485, 6024.3072046714315, 6024.518038556905, 6027.849303767441, 5557.527610153183, 5803.970980145073, 5809.099589563455, 5809.331926828299, 5811.27359080115, 5879.676617786063, 5948.167256583995, 5963.2844058713235, 5965.91051134242, 6061.848453788691, 5670.376258611467, 5670.546356291405, 5672.7730890763905, 5726.4273572642405, 5739.225204597493, 5764.740586673526, 5768.682722450306, 5770.5095066919785, 5771.278590176228, 5772.278465191851, 5402.324709411324, 5439.836804895701, 5511.751971161227, 5632.971835140798, 5635.830925072254, 5608.0, 5630.0, 5662.886742265049, 5737.168110623853, 5750.856228594319, 5660.349059858005, 5661.547076233809, 5663.122216056518, 5666.291713535808, 5714.371419143974, 5643.238162848127, 5643.32280126371, 5683.232763576864, 5693.8291851242875, 5725.16985037159, 5387.488188622075, 5464.207689885024, 5503.3395992481155, 5511.22842802016, 5577.330720313588], "value": 5259.624006236769, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.4614841937392, 600.147790138004, 608.7869245763982, 625.6652690810414, 634.7714822663837, 31171.376572468536, 31678.524822127656, 41828.372574411405, 43145.0, 43198.0, 40636.18727625453, 44101.0, 44305.556944430544, 44339.0, 44361.556384436146, 8747.081556436578, 8915.465072095663, 8939.195472407482, 8941.284697224239, 8946.284297256236, 7984.361251099927, 8168.714095006676, 8170.591470426484, 8805.911940880605, 10436.582536698523, 10472.738181545446, 10886.673399797979, 10895.182861285395, 10895.455227238606, 10896.564137434492, 10732.624358147428, 10819.621313254078, 10836.674899752981, 10859.945700271526, 10867.891321086767, 10751.784964300748, 10815.297005694605, 10816.945915270373, 10819.242653014293, 10822.134229261641, 40483.59516404857, 40730.185396291905, 40740.0, 40778.18443631111, 40853.38719919204, 3405.0, 3523.0352303522945, 3535.169235229719, 3725.4225595032544, 3906.0234941264684, 31171.0, 31631.84184079065, 31692.366152676816, 31955.0, 32701.50947735786, 4250.659947204216, 4288.549702281247, 4290.163418133465, 4372.6064654180955, 4411.595680354215, 318164.0, 320222.0, 320291.0, 320451.0, 320621.0, 50300.748496257285, 50411.24383134256, 50451.24323135156, 50467.24299135516, 50531.74734126379, 35495.0, 36161.27677446489, 36191.0, 51858.48141518612, 52001.7399912998, 15226.46707365237, 15694.293756780744, 15805.762913556306, 15810.683786324209, 15817.0, 11634.069274458023, 11660.53357865676, 11667.124965627612, 11667.824982625267, 11668.76662466746, 16479.423220187236, 16983.49049528516, 18243.0, 18627.441176764718, 18933.905330473535, 6895.207051189077, 6984.333225056785, 7011.228764835864, 7135.357817796319, 7173.282671732785, 922.2714055895767, 1043.8016776812533, 1050.3120456101267, 1060.5757696921294, 1065.1106326217696, 31703.682963170075, 31791.36417271688, 32175.35649287048, 32284.0, 32323.838380808415, 1114.648885601033, 1171.77736230116, 1180.4451907603413, 1195.4202211927209, 1209.5766481731323, 16742.162891855358, 16924.492265232064, 16993.23530441133, 17054.74417883733, 17153.228104735317, 482058.0, 485079.0, 485498.0, 486375.0, 486953.0, 56318.71840640771, 56721.43278567244, 56757.0, 57020.0, 57030.71484642633, 1206.8732783057653, 1250.5623031938749, 1274.1908887856277, 1328.920264784116, 1333.8932885369147, 28137.43725125445, 32472.67527324791, 32513.187170320933, 32880.0, 33254.16864578405, 48555.51444485651, 49359.0, 49466.0, 49492.75253623853, 49507.50492495029, 371005.0, 371648.0, 372321.0, 372377.0, 372605.0, 27148.1855544334, 27594.724052759215, 27887.860560697067, 28054.719452806028, 29218.26954326074, 46145.76927115343, 46163.30755038744, 46275.305870412645, 46778.76610616925, 46900.29649555191, 36725.0, 37297.27027297357, 38163.0, 39134.0, 39203.2159356817, 38412.42381364338, 38554.61445385622, 39074.41388379233, 39855.2028959425, 40286.597134029456, 35578.822105890344, 37401.43897841589, 37640.43539346857, 37745.0, 37820.24359512849, 33594.49608255829, 34925.0, 35170.47244291389, 35776.63350497446, 35850.28299434049, 25582.61626075573, 25860.482790344464, 25864.724411014013, 25942.22173334803, 26007.60988585135], "value": 19505.620328743058, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.5601278465842, 368.29103974848425, 381.79001549147966, 384.47519136378844, 395.12676983865657, 14368.20974846383, 16868.0, 17762.467125986208, 18714.812851871477, 19066.0, 17382.826171738277, 17589.472315830546, 18130.274789008425, 18131.184096715646, 18302.72545911809, 5209.479052094798, 5498.202760599711, 5499.422560631137, 5499.697516636584, 5500.119980803072, 3940.7886553053863, 4005.239004589119, 5380.569554435636, 5471.343438787351, 5472.644278121929, 5710.172025056364, 6625.9668701656665, 6629.469642428594, 6636.203655561315, 6637.435817955479, 6112.908306375408, 6139.631622102644, 6366.713497892606, 6606.504512161583, 6647.867042659144, 5936.821895343103, 5937.139114828326, 5940.940590594082, 5941.079132734433, 5946.226990491208, 14300.642483937881, 14302.64243393913, 14306.57080287593, 14310.64223394413, 14342.0, 2355.740868504463, 2357.6934998450265, 2399.3281881073326, 2409.3013026222375, 2503.236512863576, 10299.53652085658, 10836.729081772939, 10905.727356816064, 13071.888889444313, 13847.238401887893, 1858.3681548273516, 1953.7460130183126, 1970.8423326133875, 1987.0859404673868, 1998.7801341852385, 74366.25633743647, 79585.0, 80324.19675803225, 82084.58957705174, 82539.0, 10517.52671129801, 10938.945305273422, 11395.777823324537, 11401.828972565418, 11487.368194749202, 15517.45688900883, 15533.223338833013, 15560.299786509635, 15562.377504899678, 15562.377504899903, 7757.146713861471, 7952.642131104114, 7983.481073730189, 8135.7152499662225, 8251.669933202726, 7696.384289256846, 7804.2585954334245, 8015.238552337519, 8054.637541310655, 8135.877961830577, 4747.905041899143, 4804.567588917014, 4823.1800593899125, 4840.322354870321, 4925.556699897026, 1841.4128149949343, 1855.7123645834918, 1856.136896343207, 1862.3574866670976, 1900.5058684742066, 724.4964749499153, 871.812560299526, 885.1369914333474, 898.4474548152839, 971.4608392342318, 17170.141492925304, 17190.828091719173, 18280.54298642518, 18665.626687466447, 19015.809841901682, 876.7150676030316, 892.1658249536704, 896.8027034052498, 909.2271569166288, 919.7240827751648, 9271.165595096474, 10144.746381340525, 10514.158867290598, 10661.39196469398, 10694.037536621741, 454488.0, 457527.0, 477299.0, 477455.0, 479169.0, 53548.0, 63109.0, 88900.11099889048, 92520.53739731258, 92552.0, 985.7387792235063, 1006.1950439648252, 1020.698893826323, 1023.6673081248624, 1024.71820249432, 15634.140122293384, 16820.411285604947, 17187.3984410545, 17778.822211777715, 18145.818541814413, 41748.79125604353, 42905.35641965435, 43186.35220471633, 43544.56455435405, 44158.0, 57397.426025740875, 57458.42541574531, 57670.13494797665, 57828.0, 58882.0, 7363.300486453778, 7545.849083018199, 7704.768856934301, 7866.9213307866185, 8125.390595705464, 13109.016823738448, 13285.535006274735, 13394.330283485982, 13534.526291579747, 13593.52422665202, 11397.430128493377, 11663.708407289885, 11726.589569365373, 12059.879401205875, 12128.211666241667, 10524.894751052392, 11508.654740357802, 11787.469563869476, 11839.112066594867, 11889.524419023488, 11629.08120160164, 11704.590339338083, 11755.588554400554, 12228.266304021787, 12599.307038112991, 7857.096433909945, 7921.128675845767, 8104.27061564462, 8124.309433697966, 8193.95151212197, 10634.627788027381, 11625.6512304631, 11718.472668730099, 11784.70538236551, 12236.877631223573], "value": 8934.003436256495, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1201.5974648492754, 1218.8293638890557, 1278.2522224498668, 1599.264338404334, 1624.9512514624566, 6893.138357705287, 7145.57126572406, 7992.320652744516, 8557.144285571447, 8560.315174786017, 7968.641411136498, 8295.83408331833, 8302.626381812817, 8525.658973641062, 8531.530765807878, 2302.9193978210724, 2318.2349824557855, 2330.9650355244685, 2331.125827814561, 2333.6266197408418, 1968.6456437841182, 2032.227753453693, 2295.345826439465, 2354.0113152475915, 2360.055977608953, 2206.6359050756605, 2286.542691461706, 2288.8054515366216, 2307.7576854430213, 2312.4681323295654, 2241.3724157236, 2246.7528571857083, 2263.9207627733117, 2287.9428014299774, 2290.2900100968586, 2258.7402448718444, 2267.614505534063, 2281.9201327953606, 2355.8115350771895, 2374.952500949971, 8436.915630843674, 8485.618147183392, 8494.362922780816, 8495.957520212422, 8502.872456913152, 5093.5415812576675, 5236.947630523722, 5239.083160446907, 5241.868953276198, 5246.134387826004, 3384.13704505352, 3395.371856206585, 3425.743069269815, 3444.534987776643, 3492.039689085522, 1067.9572817087308, 1142.8400023996564, 1142.879878251957, 1160.7678464307173, 1172.2416375436844, 11609.709757256052, 11666.416679166092, 11672.824907626307, 11741.119416043832, 11752.941235293854, 4024.63778259958, 4328.11273688893, 4433.357163211316, 4450.265706158512, 4467.218236808546, 9168.954155229181, 9181.081891810765, 9185.77035574116, 9188.40275382098, 9195.218406435528, 5103.974480127576, 5107.33604631403, 5108.974455127701, 5110.207917772751, 5111.386633603991, 4660.440747110369, 4698.976505117453, 4769.689970151929, 4778.784954677048, 4781.737004464788, 3559.750817442806, 3623.3659109655705, 3647.7993710345654, 3680.7791532508136, 3710.14666626672, 1020.9030142136485, 1073.1897417449775, 1087.2226358153957, 1087.6465148826662, 1120.5349779841438, 784.2236186175759, 916.6929078758691, 922.31748506105, 933.4446004627235, 936.0031566381782, 5632.155176723442, 5646.463585959327, 5745.712714364265, 5749.223854779551, 5792.797252096157, 900.7297810656777, 915.2037727177266, 915.7069737683877, 928.6192661008954, 933.6405483888616, 3948.526176858738, 4068.1253530491085, 4068.384761505917, 4138.13099249161, 4184.456020717348, 9801.852972205423, 10293.897061029294, 10300.845487317696, 10307.072363487323, 10308.639197628198, 10205.642802501878, 10207.336523125972, 10222.131118854832, 10235.078842904175, 10252.436116013541, 7753.883691744629, 7935.166807485246, 7942.364610831235, 7946.364290856717, 7946.443748937634, 5572.693501857437, 5603.971980140236, 5769.913451298318, 5798.6810725410505, 5873.588848780544, 9474.52627368615, 9504.47725375111, 9504.524773761423, 9549.09283618055, 9573.569189386355, 9412.811743764949, 9759.951200243953, 9805.950970245103, 9852.704418867446, 9873.50632468388, 7099.396551292992, 7231.819204519929, 7234.855302893808, 7235.131784185932, 7255.56466612005, 7896.960515197387, 8046.959765201371, 8072.83854322922, 8076.1923807621115, 8087.83824323522, 5333.413264592525, 6853.451723862178, 6926.861462770616, 6975.9302406975285, 7045.823854403476, 7171.8565628688175, 7192.31672991065, 7278.636068196675, 7332.5967071811565, 7453.962730186315, 6653.201615806134, 6733.528652994243, 6794.592324460548, 6813.523053386215, 6815.591064536144, 4869.245266983481, 4923.433805112458, 4938.38270216223, 5007.899842003067, 5206.687598744087, 4897.3878265216845, 4982.377202849644, 4986.276989836381, 5039.72281524505, 5174.741262936914], "value": 4417.426533859593, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.6515528384629, 326.4026830899454, 328.33675974531445, 332.808635034855, 335.98320083995793, 5062.21535661972, 5216.6869987800665, 5238.5023422774875, 5274.681329667583, 5287.1540553511395, 4970.900581988358, 5102.285680004802, 5129.717865517395, 5151.536361727443, 5188.221766734991, 4148.149629325981, 4163.666906647461, 4167.541570427251, 4175.874723758277, 4178.415021896937, 4025.6175663311938, 4119.40268661044, 4147.5645057269, 4185.455890734215, 4195.874123776276, 4081.69387295954, 4101.692373072016, 4105.774182419966, 4107.835686572534, 4108.938365924499, 4079.7552146870985, 4084.9387259191135, 4089.3865920111925, 4090.6318431341174, 4093.222287765345, 3631.963680363215, 3635.1093981974323, 3642.3079614873354, 3651.580068292154, 3660.2313514162056, 5002.82490112848, 5034.798608055673, 5035.54680078791, 5041.899162016776, 5086.567641750456, 4660.743659098748, 4662.417197850269, 4667.509911459316, 4673.392458980345, 4676.275177347517, 5432.239486471857, 5445.292112025411, 5446.754896029688, 5448.782048718046, 5481.451854814526, 3804.334241507725, 3909.5308562972627, 3939.951225362824, 3950.3481925482547, 3988.6809055275507, 5591.944080559224, 5624.971875140598, 5629.874025194978, 5642.322921249435, 5667.376588575212, 4026.1343811080174, 4036.647723012765, 4046.3323551613653, 4074.1851629674184, 4095.8736347504673, 4031.173609410064, 4081.836726530965, 4097.160082183145, 4102.528209255974, 4149.730267532601, 4610.792514336863, 4626.588890388397, 4631.814727410933, 4636.629069674418, 4637.791299391535, 5443.129099344165, 5493.423190565013, 5495.862603434866, 5497.433231528995, 5508.256385388001, 1310.8885744711806, 1313.39583791457, 1394.1635018988525, 1403.9789403158961, 1417.305520295048, 879.8416285068749, 894.190757364586, 901.6844104563481, 903.7876099116834, 915.9786837675944, 4646.79089440976, 4648.395708557866, 4661.857844828039, 4661.906761864811, 4663.813447462131, 4845.491223421561, 4865.0, 4870.1233777920315, 4877.0, 4896.363472748591, 4643.3284017753585, 4649.395578574764, 4665.720056796603, 4698.929516057262, 4699.694519856198, 2780.944381112407, 2995.0, 3005.609270794783, 3014.668386477486, 3015.32155265068, 5832.737526811304, 5837.708114594253, 5851.882962340815, 5876.6180198286975, 5881.411858814085, 5480.561555075585, 5726.198332233407, 5757.424257574293, 5764.875849209364, 5774.595778295563, 5760.8271751847515, 5770.307563092456, 5795.8551036224435, 5799.507041901401, 5812.796552120655, 5603.8318850432925, 5628.268325117872, 5637.5489960802215, 5641.971790141023, 5644.915326270027, 5338.1049727346235, 5559.416261292506, 5564.666120032811, 5593.0, 5610.158476228598, 5849.830033993133, 5850.385709500441, 5852.824415267549, 5875.823725288248, 5875.970620146872, 3976.3240249158293, 4063.8374465022252, 4074.4720729726355, 4075.42943987836, 4078.5513593505284, 5355.30381050461, 5643.915341269966, 5681.147827825859, 5688.687122208318, 5693.629914055573, 5253.658512196848, 5386.78797270611, 5459.399466058651, 5465.6447330923365, 5477.397486276586, 5413.240696773643, 5417.674939503485, 5448.945510545002, 5456.48163424474, 5473.8357849264585, 5236.0, 5406.83779486616, 5429.837104886859, 5443.455654434683, 5454.672719636835, 5460.91808622863, 5478.507279188039, 5489.752961116679, 5508.338999319947, 5517.779288828562, 5383.40782513931, 5400.270963419888, 5418.241446197457, 5437.564994800486, 5451.945480545302], "value": 4139.393950644872, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.7596341280553, 700.5376451541983, 750.9586972716498, 762.2872614105811, 790.9564973926435, 13127.671808204788, 13784.241866697354, 13815.03294769364, 14011.439542418304, 14068.507602233936, 12857.678558036054, 13053.804192937114, 13062.346882655876, 13078.215307081582, 13085.0, 649.7011374767612, 660.8447014951482, 762.5653377574785, 776.0454640791829, 798.9041315042203, 802.5866678660494, 805.1425232127795, 805.3959530352236, 805.3999770171231, 805.7582725182451, 840.8570543007672, 844.3835999720208, 844.8817165596821, 845.0366582096415, 845.3406343052429, 667.706209267923, 690.5752961928428, 692.7402224165937, 693.448708276921, 843.4180415513307, 593.0, 612.2713970375239, 617.200725061047, 617.4844005255617, 617.6355949989482, 13496.0, 13555.86444135556, 13597.252151131685, 13615.727685446236, 13627.863721362759, 12919.806202906964, 12942.741145177139, 13016.609501714964, 13076.346182690922, 13104.80342794859, 11236.943815280953, 11262.859698822174, 11309.377984210865, 11544.480498377508, 11562.132840036948, 4172.5410204877435, 4187.602177793105, 4233.174530966463, 4395.912081758379, 4440.977795111036, 53118.20322695163, 58638.70680646569, 59584.10623840646, 60900.0, 61513.38486615122, 10199.439030853375, 10675.679729608124, 10848.240623156304, 10909.236353455182, 11050.557977680803, 19452.513687157934, 19481.0, 19486.610267794564, 19486.902565487082, 19498.31755888537, 7747.341475974606, 7850.371970242481, 7944.960275198587, 8415.873761893576, 8439.873401898976, 4448.332750087513, 4493.483249426293, 4531.229690952546, 4610.147122782296, 4665.766711664403, 3408.863645454204, 3519.9472007919903, 3527.8588856445967, 3528.1003344147593, 3534.3108093921437, 550.7906995341745, 552.6573524414888, 559.2254727202853, 572.5362456410321, 576.2681394628798, 645.9289478157399, 659.9670016499156, 680.43863812355, 686.8660611180771, 734.7428400060043, 9201.861972070425, 9272.72181834546, 9292.210162136294, 9344.205742511962, 9345.205657519187, 610.7526451787033, 656.8916128838783, 662.7183447035087, 692.9930700693029, 716.9749058782918, 4384.364267181241, 4681.250999840009, 4763.428388593391, 4769.689970151999, 4844.176489996638, 86091.0, 89213.94149053232, 89682.10317896737, 90922.0, 91931.0, 61718.0, 64535.354646452935, 79434.6028269855, 80406.0, 80613.59693201496, 40327.3950890731, 41696.79151604223, 60956.695216523636, 65545.34454655487, 67294.32705672881, 8233.46482478661, 8729.432586882087, 8862.0, 9134.725958221265, 9293.86059209126, 42822.35766463443, 42938.0, 42980.78509607557, 43434.0, 44689.55310446854, 36196.27607447889, 36543.81728091343, 39139.608603914734, 56897.0, 57007.71496142493, 11537.711557211136, 11631.418429078682, 12059.75880482403, 12156.878431215575, 12424.440900159696, 13399.0, 13495.39270732839, 13589.52436664712, 13967.231802250973, 14037.368318425491, 12771.680707982376, 13026.413811378321, 13398.196108233537, 13707.725845482835, 13876.655263327564, 12641.810372844231, 12931.676708082374, 12996.74332181151, 13472.326383680973, 13505.932470337586, 12423.689407764878, 12435.547467394343, 12714.745705085661, 13098.672533186747, 13166.144200627312, 9926.0, 10677.822105854331, 11082.501287441923, 11083.501242443948, 11504.482298296429, 10059.346142500714, 11344.289341993568, 11391.259568128045, 11416.372099534274, 11553.653390398302], "value": 6852.667626526076, "unit": "score"}], "name": "dromaeo_css", "value": 6972.07591559772, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 112.0, 113.0, 112.0, 115.0, 112.0, 113.0, 115.0, 112.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 125.0, 121.0, 164.0, 125.0, 129.0, 124.0, 122.0, 155.0, 124.0], "value": 133.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 163.0, 161.0, 162.0, 163.0, 162.0, 161.0, 161.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 100.0, 76.0, 75.0, 77.0, 77.0, 100.0, 77.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 114.0, 83.0, 84.0, 83.0, 106.0, 83.0, 83.0, 115.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 116.0, 118.0, 117.0, 120.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 85.0, 84.0, 85.0, 84.0, 84.0, 84.0, 85.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 51.0, 52.0, 51.0, 53.0, 52.0, 53.0, 53.0, 54.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 60.0, 60.0, 60.0, 61.0, 60.0, 60.0, 60.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 84.0, 79.0, 80.0, 79.0, 81.0, 79.0, 80.0, 78.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 133.0, 130.0, 132.0, 133.0, 129.0, 133.0, 143.0, 178.0, 149.0], "value": 140.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 166.0, 167.0, 165.0, 169.0, 170.0, 172.0, 164.0, 164.0], "value": 167.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 73.0, 65.0, 65.0, 66.0, 65.0, 66.0, 63.0], "value": 65.8, "unit": "score"}], "name": "kraken", "value": 1493.7999999999997, "alertThreshold": 2.0}]} 07:39:07 INFO - Return code: 0 07:39:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:39:07 INFO - # TBPL SUCCESS # 07:39:07 INFO - Running post-action listener: _resource_record_post_action 07:39:07 INFO - [mozharness: 2016-11-02 14:39:07.644058Z] Finished run-tests step (success) 07:39:07 INFO - Running post-run listener: _resource_record_post_run 07:39:07 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 2617344; Write bytes: 400330752; Read time: 1444; Write time: 338440 07:39:07 INFO - TinderboxPrint: CPU usage
13.1% 07:39:07 INFO - TinderboxPrint: I/O read bytes / time
2,617,344 / 1,444 07:39:07 INFO - TinderboxPrint: I/O write bytes / time
400,330,752 / 338,440 07:39:07 INFO - TinderboxPrint: CPU idle
8,298.8 (86.9%) 07:39:07 INFO - TinderboxPrint: CPU user
1,199.3 (12.6%) 07:39:07 INFO - TinderboxPrint: Swap in / out
0 / 0 07:39:07 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 109436928; Read time: 0; Write time: 94312 07:39:07 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 2617344; Write bytes: 290480128; Read time: 1444; Write time: 244104 07:39:08 INFO - Running post-run listener: _upload_blobber_files 07:39:08 INFO - Blob upload gear active. 07:39:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:39:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:39:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:39:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:39:08 INFO - (blobuploader) - INFO - Open directory for files ... 07:39:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:39:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:39:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:39:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:39:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:39:09 INFO - (blobuploader) - INFO - Done attempting. 07:39:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:39:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:39:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:39:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:39:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:39:10 INFO - (blobuploader) - INFO - Done attempting. 07:39:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:39:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:39:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:39:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:39:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:39:14 INFO - (blobuploader) - INFO - Done attempting. 07:39:14 INFO - (blobuploader) - INFO - Iteration through files over. 07:39:14 INFO - Return code: 0 07:39:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:39:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:39:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/347a4c23b1638b770213cd85f6596a3c26bba0fa390b470bc8c0192b4858e7865829086acb76b584ff8a6a0d05b9ac9d00785a26937fe7565537a9859419956d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/df73b5947bcce33b919cc4da69fb2a940c926ffafeef962bbe721df38d11912cf91ad2b3423c47ac2bb59b369b61edf4ec9f11da846040ab61745fc3c3aafada", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/624889fc38f721658dfacb522402b96bf26e303a9f0560d4a42f40f1bc35833568672c29810630f420a47e7eab554711e6d9feffdeb492689a74000ff5b8fb9d"} 07:39:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:39:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:39:14 INFO - Contents: 07:39:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/347a4c23b1638b770213cd85f6596a3c26bba0fa390b470bc8c0192b4858e7865829086acb76b584ff8a6a0d05b9ac9d00785a26937fe7565537a9859419956d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/df73b5947bcce33b919cc4da69fb2a940c926ffafeef962bbe721df38d11912cf91ad2b3423c47ac2bb59b369b61edf4ec9f11da846040ab61745fc3c3aafada", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/624889fc38f721658dfacb522402b96bf26e303a9f0560d4a42f40f1bc35833568672c29810630f420a47e7eab554711e6d9feffdeb492689a74000ff5b8fb9d"} 07:39:14 INFO - Running post-run listener: copy_logs_to_upload_dir 07:39:14 INFO - Copying logs to upload dir... 07:39:14 INFO - mkdir: /builds/slave/test/build/upload/logs 07:39:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.150919 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-11-02 07:39:13.766272) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-02 07:39:13.769485) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1478096314.179477-1936371055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/347a4c23b1638b770213cd85f6596a3c26bba0fa390b470bc8c0192b4858e7865829086acb76b584ff8a6a0d05b9ac9d00785a26937fe7565537a9859419956d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/df73b5947bcce33b919cc4da69fb2a940c926ffafeef962bbe721df38d11912cf91ad2b3423c47ac2bb59b369b61edf4ec9f11da846040ab61745fc3c3aafada", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/624889fc38f721658dfacb522402b96bf26e303a9f0560d4a42f40f1bc35833568672c29810630f420a47e7eab554711e6d9feffdeb492689a74000ff5b8fb9d"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478061457/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011415 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478061457/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/347a4c23b1638b770213cd85f6596a3c26bba0fa390b470bc8c0192b4858e7865829086acb76b584ff8a6a0d05b9ac9d00785a26937fe7565537a9859419956d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/df73b5947bcce33b919cc4da69fb2a940c926ffafeef962bbe721df38d11912cf91ad2b3423c47ac2bb59b369b61edf4ec9f11da846040ab61745fc3c3aafada", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/624889fc38f721658dfacb522402b96bf26e303a9f0560d4a42f40f1bc35833568672c29810630f420a47e7eab554711e6d9feffdeb492689a74000ff5b8fb9d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-02 07:39:13.795118) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 07:39:13.795436) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1478096314.179477-1936371055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004428 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 07:39:13.877981) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-02 07:39:13.878302) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-02 07:39:13.878601) ========= ========= Total master_lag: 0.16 =========